builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0074 starttime: 1474641967.18 results: success (0) buildid: 20160923065658 builduid: 86aebe46671744bcb08747382b71fcb1 revision: e26037d2a25382b8b8a70d6b0390dc1cbe370f5b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-23 07:46:07.182294) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-23 07:46:07.182741) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-23 07:46:07.183016) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-23 07:46:07.388367) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 07:46:07.388687) ========= 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.pHfGeLPyoY/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.8XBfIcQGsH/Listeners TMPDIR=/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-09-23 07:46:07-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 15.0M=0.001s 2016-09-23 07:46:07 (15.0 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.517724 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 07:46:07.929383) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 07:46:07.929663) ========= 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.pHfGeLPyoY/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.8XBfIcQGsH/Listeners TMPDIR=/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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.026915 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 07:46:07.980985) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-09-23 07:46:07.981308) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev e26037d2a25382b8b8a70d6b0390dc1cbe370f5b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev e26037d2a25382b8b8a70d6b0390dc1cbe370f5b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.pHfGeLPyoY/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.8XBfIcQGsH/Listeners TMPDIR=/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-09-23 07:46:08,002 truncating revision to first 12 chars 2016-09-23 07:46:08,002 Setting DEBUG logging. 2016-09-23 07:46:08,002 attempt 1/10 2016-09-23 07:46:08,002 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/e26037d2a253?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-23 07:46:10,024 unpacking tar archive at: autoland-e26037d2a253/testing/mozharness/ program finished with exit code 0 elapsedTime=2.267531 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-09-23 07:46:10.276530) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-23 07:46:10.276850) ========= script_repo_revision: e26037d2a25382b8b8a70d6b0390dc1cbe370f5b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-23 07:46:10.277245) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-23 07:46:10.277527) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-23 07:46:10.296178) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 34 secs) (at 2016-09-23 07:46:10.296641) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.pHfGeLPyoY/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.8XBfIcQGsH/Listeners TMPDIR=/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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 07:46:10 INFO - MultiFileLogger online at 20160923 07:46:10 in /builds/slave/test 07:46:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 07:46:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:46:10 INFO - {'append_to_log': False, 07:46:10 INFO - 'base_work_dir': '/builds/slave/test', 07:46:10 INFO - 'blob_upload_branch': 'Autoland', 07:46:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:46:10 INFO - 'branch': 'Autoland', 07:46:10 INFO - 'buildbot_json_path': 'buildprops.json', 07:46:10 INFO - 'config_files': ('talos/mac_config.py',), 07:46:10 INFO - 'default_actions': ('clobber', 07:46:10 INFO - 'read-buildbot-config', 07:46:10 INFO - 'download-and-extract', 07:46:10 INFO - 'populate-webroot', 07:46:10 INFO - 'create-virtualenv', 07:46:10 INFO - 'install', 07:46:10 INFO - 'run-tests'), 07:46:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:46:10 INFO - 'download_minidump_stackwalk': True, 07:46:10 INFO - 'download_symbols': 'ondemand', 07:46:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:46:10 INFO - 'tooltool.py': '/tools/tooltool.py', 07:46:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:46:10 INFO - '/tools/misc-python/virtualenv.py')}, 07:46:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:46:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:46:10 INFO - 'installer_path': 'installer.exe', 07:46:10 INFO - 'log_level': 'info', 07:46:10 INFO - 'log_name': 'talos', 07:46:10 INFO - 'log_to_console': True, 07:46:10 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:46:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:46:10 INFO - 'opt_config_files': (), 07:46:10 INFO - 'pip_index': False, 07:46:10 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:46:10 INFO - 'cmd': ('bash', 07:46:10 INFO - '-c', 07:46:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:46:10 INFO - 'enabled': True, 07:46:10 INFO - 'halt_on_failure': False, 07:46:10 INFO - 'name': 'check_screen_resolution'},), 07:46:10 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:46:10 INFO - 'cmd': ('bash', 07:46:10 INFO - '-c', 07:46:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:46:10 INFO - 'enabled': True, 07:46:10 INFO - 'halt_on_failure': False, 07:46:10 INFO - 'name': 'check_screen_resolution'},), 07:46:10 INFO - 'run_cmd_checks_enabled': True, 07:46:10 INFO - 'sps_profile': False, 07:46:10 INFO - 'sps_profile_interval': 0, 07:46:10 INFO - 'suite': 'dromaeojs', 07:46:10 INFO - 'system_bits': '32', 07:46:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:46:10 INFO - 'title': 't-yosemite-r7-0074', 07:46:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:46:10 INFO - 'use_talos_json': True, 07:46:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:46:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:46:10 INFO - 'work_dir': 'build'} 07:46:10 INFO - [mozharness: 2016-09-23 14:46:10.445082Z] Running clobber step. 07:46:10 INFO - Running pre-action listener: _resource_record_pre_action 07:46:10 INFO - Running main action method: clobber 07:46:10 INFO - rmtree: /builds/slave/test/build 07:46:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:46:12 INFO - Running post-action listener: _resource_record_post_action 07:46:12 INFO - [mozharness: 2016-09-23 14:46:12.682558Z] Finished clobber step (success) 07:46:12 INFO - [mozharness: 2016-09-23 14:46:12.682701Z] Running read-buildbot-config step. 07:46:12 INFO - Running pre-action listener: _resource_record_pre_action 07:46:12 INFO - Running main action method: read_buildbot_config 07:46:12 INFO - Using buildbot properties: 07:46:12 INFO - { 07:46:12 INFO - "project": "", 07:46:12 INFO - "product": "firefox", 07:46:12 INFO - "script_repo_revision": "production", 07:46:12 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 07:46:12 INFO - "repository": "", 07:46:12 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 07:46:12 INFO - "buildid": "20160923065658", 07:46:12 INFO - "pgo_build": "False", 07:46:12 INFO - "basedir": "/builds/slave/test", 07:46:12 INFO - "buildnumber": 299, 07:46:12 INFO - "slavename": "t-yosemite-r7-0074", 07:46:12 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 07:46:12 INFO - "platform": "yosemite_r7", 07:46:12 INFO - "scheduler": "tests-autoland-macosx64-talos", 07:46:12 INFO - "branch": "autoland", 07:46:12 INFO - "repo_path": "integration/autoland", 07:46:12 INFO - "revision": "e26037d2a25382b8b8a70d6b0390dc1cbe370f5b", 07:46:12 INFO - "stage_platform": "macosx64", 07:46:12 INFO - "builduid": "86aebe46671744bcb08747382b71fcb1", 07:46:12 INFO - "slavebuilddir": "test" 07:46:12 INFO - } 07:46:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/O0qTAEdFQDCpgJqGmIJgow/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 07:46:12 INFO - Running post-action listener: _resource_record_post_action 07:46:12 INFO - [mozharness: 2016-09-23 14:46:12.685575Z] Finished read-buildbot-config step (success) 07:46:12 INFO - [mozharness: 2016-09-23 14:46:12.685693Z] Running download-and-extract step. 07:46:12 INFO - Running pre-action listener: _resource_record_pre_action 07:46:12 INFO - Running main action method: download_and_extract 07:46:12 INFO - mkdir: /builds/slave/test/build/tests 07:46:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:12 INFO - trying https://queue.taskcluster.net/v1/task/O0qTAEdFQDCpgJqGmIJgow/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 07:46:12 INFO - Downloading https://queue.taskcluster.net/v1/task/O0qTAEdFQDCpgJqGmIJgow/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 07:46:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O0qTAEdFQDCpgJqGmIJgow/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 07:46:13 INFO - Downloaded 1199 bytes. 07:46:13 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 07:46:13 INFO - Using the following test package requirements: 07:46:13 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 07:46:13 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 07:46:13 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 07:46:13 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 07:46:13 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 07:46:13 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 07:46:13 INFO - u'jsshell-mac.zip'], 07:46:13 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 07:46:13 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 07:46:13 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 07:46:13 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 07:46:13 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 07:46:13 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 07:46:13 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 07:46:13 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 07:46:13 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 07:46:13 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 07:46:13 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 07:46:13 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:46:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/O0qTAEdFQDCpgJqGmIJgow/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 07:46:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O0qTAEdFQDCpgJqGmIJgow/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:46:13 INFO - Fetch https://queue.taskcluster.net/v1/task/O0qTAEdFQDCpgJqGmIJgow/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 07:46:14 INFO - Expected file size: 16438806 07:47:40 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 07:47:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/O0qTAEdFQDCpgJqGmIJgow/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 07:47:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O0qTAEdFQDCpgJqGmIJgow/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:47:40 INFO - Fetch https://queue.taskcluster.net/v1/task/O0qTAEdFQDCpgJqGmIJgow/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 07:47:40 INFO - Expected file size: 16438806 07:47:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/O0qTAEdFQDCpgJqGmIJgow/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 07:47:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O0qTAEdFQDCpgJqGmIJgow/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 07:47:47 INFO - Fetch https://queue.taskcluster.net/v1/task/O0qTAEdFQDCpgJqGmIJgow/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 07:47:48 INFO - Expected file size: 14414059 07:47: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')]} 07:47:49 INFO - trying https://queue.taskcluster.net/v1/task/O0qTAEdFQDCpgJqGmIJgow/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 07:47:49 INFO - Downloading https://queue.taskcluster.net/v1/task/O0qTAEdFQDCpgJqGmIJgow/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 07:47:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O0qTAEdFQDCpgJqGmIJgow/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 07:47:52 INFO - Downloaded 111578700 bytes. 07:47:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/O0qTAEdFQDCpgJqGmIJgow/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 07:47:52 INFO - mkdir: /builds/slave/test/properties 07:47:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:47:52 INFO - Writing to file /builds/slave/test/properties/build_url 07:47:52 INFO - Contents: 07:47:52 INFO - build_url:https://queue.taskcluster.net/v1/task/O0qTAEdFQDCpgJqGmIJgow/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 07:47:53 INFO - Running post-action listener: _resource_record_post_action 07:47:53 INFO - Running post-action listener: set_extra_try_arguments 07:47:53 INFO - [mozharness: 2016-09-23 14:47:53.478847Z] Finished download-and-extract step (success) 07:47:53 INFO - [mozharness: 2016-09-23 14:47:53.478962Z] Running populate-webroot step. 07:47:53 INFO - Running pre-action listener: _resource_record_pre_action 07:47:53 INFO - Running main action method: populate_webroot 07:47:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:47:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:47:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:47:53 INFO - '--tppagecycles', 07:47:53 INFO - '7'], 07:47:53 INFO - 'tests': ['tsvgm']}}, 07:47:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:47:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:47:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:47:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:47:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:47:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:47:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:47:53 INFO - 'talos_options': ['--disable-e10s'], 07:47:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:47:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:47:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:47:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:47:53 INFO - 'talos_options': ['--disable-e10s'], 07:47:53 INFO - 'tests': ['damp', 'tps']}, 07:47:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:47:53 INFO - 'tests': ['damp', 'tps']}, 07:47:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:47:53 INFO - 'tests': ['dromaeo_dom']}, 07:47:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:47:53 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:47:53 INFO - 'tests': ['basic_compositor_video']}, 07:47:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:47:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:47:53 INFO - 'tests': ['a11yr', 07:47:53 INFO - 'ts_paint', 07:47:53 INFO - 'tpaint', 07:47:53 INFO - 'sessionrestore', 07:47:53 INFO - 'sessionrestore_no_auto_restore', 07:47:53 INFO - 'tabpaint']}, 07:47:53 INFO - 'other-e10s': {'tests': ['a11yr', 07:47:53 INFO - 'ts_paint', 07:47:53 INFO - 'tpaint', 07:47:53 INFO - 'sessionrestore', 07:47:53 INFO - 'sessionrestore_no_auto_restore', 07:47:53 INFO - 'tabpaint']}, 07:47:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:47:53 INFO - 'ts_paint', 07:47:53 INFO - 'tpaint', 07:47:53 INFO - 'sessionrestore', 07:47:53 INFO - 'sessionrestore_no_auto_restore', 07:47:53 INFO - 'tabpaint']}, 07:47:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:47:53 INFO - 'ts_paint', 07:47:53 INFO - 'tpaint', 07:47:53 INFO - 'sessionrestore', 07:47:53 INFO - 'sessionrestore_no_auto_restore', 07:47:53 INFO - 'tabpaint']}, 07:47:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:47:53 INFO - 'tests': ['a11yr', 07:47:53 INFO - 'ts_paint', 07:47:53 INFO - 'tpaint', 07:47:53 INFO - 'sessionrestore', 07:47:53 INFO - 'sessionrestore_no_auto_restore', 07:47:53 INFO - 'tabpaint']}, 07:47:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:47:53 INFO - 'tests': ['a11yr', 07:47:53 INFO - 'ts_paint', 07:47:53 INFO - 'tpaint', 07:47:53 INFO - 'sessionrestore', 07:47:53 INFO - 'sessionrestore_no_auto_restore', 07:47:53 INFO - 'tabpaint']}, 07:47:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:47:53 INFO - 'tests': ['tsvgx', 07:47:53 INFO - 'tsvgr_opacity', 07:47:53 INFO - 'tart', 07:47:53 INFO - 'tscrollx', 07:47:53 INFO - 'cart']}, 07:47:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:47:53 INFO - 'tsvgr_opacity', 07:47:53 INFO - 'tart', 07:47:53 INFO - 'tscrollx', 07:47:53 INFO - 'cart']}, 07:47:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:47:53 INFO - 'talos_options': ['--disable-e10s'], 07:47:53 INFO - 'tests': ['tp5o']}, 07:47:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:47:53 INFO - 'tests': ['tp5o']}, 07:47:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:47:53 INFO - 'talos_options': ['--disable-e10s', 07:47:53 INFO - '--xperf_path', 07:47:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:47:53 INFO - 'tests': ['tp5n']}, 07:47:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:47:53 INFO - 'talos_options': ['--xperf_path', 07:47:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:47:53 INFO - 'tests': ['tp5n']}}, 07:47:53 INFO - 'talos.zip': {'path': '', 07:47:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:47:53 INFO - Running post-action listener: _resource_record_post_action 07:47:53 INFO - [mozharness: 2016-09-23 14:47:53.497213Z] Finished populate-webroot step (success) 07:47:53 INFO - [mozharness: 2016-09-23 14:47:53.497314Z] Running create-virtualenv step. 07:47:53 INFO - Running pre-action listener: _resource_record_pre_action 07:47:53 INFO - Running main action method: create_virtualenv 07:47:53 INFO - Creating virtualenv /builds/slave/test/build/venv 07:47:53 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 07:47:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:47:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:47:53 INFO - Using real prefix '/tools/python27' 07:47:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:47:54 INFO - Installing distribute.............................................................................................................................................................................................done. 07:47:57 INFO - Installing pip.................done. 07:47:57 INFO - Return code: 0 07:47:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:47:57 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')]} 07:47:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:57 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')]} 07:47:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:57 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 0x10af2f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aea5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f912b46c300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad43d30>, '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 0x10ab69db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad3bb20>, '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.pHfGeLPyoY/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.8XBfIcQGsH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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 07:47:57 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 07:47:57 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 07:47:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pHfGeLPyoY/Render', 07:47:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:47:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:47:57 INFO - 'HOME': '/Users/cltbld', 07:47:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:47:57 INFO - 'LOGNAME': 'cltbld', 07:47:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:57 INFO - 'MOZ_NO_REMOTE': '1', 07:47:57 INFO - 'NO_EM_RESTART': '1', 07:47:57 INFO - 'PAGER': '/bin/cat', 07:47:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:47:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:57 INFO - 'PWD': '/builds/slave/test', 07:47:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:47:57 INFO - 'SHELL': '/bin/bash', 07:47:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8XBfIcQGsH/Listeners', 07:47:57 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 07:47:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:47:57 INFO - 'USER': 'cltbld', 07:47:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:47:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:47:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:57 INFO - 'XPC_FLAGS': '0x0', 07:47:57 INFO - 'XPC_SERVICE_NAME': '0', 07:47:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:47:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:57 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 07:47:57 INFO - Cleaning up... 07:47:57 INFO - Return code: 0 07:47:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:47:57 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')]} 07:47:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:57 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')]} 07:47:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:57 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 0x10af2f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aea5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f912b46c300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad43d30>, '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 0x10ab69db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad3bb20>, '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.pHfGeLPyoY/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.8XBfIcQGsH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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 07:47:57 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 07:47:57 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 07:47:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pHfGeLPyoY/Render', 07:47:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:47:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:47:57 INFO - 'HOME': '/Users/cltbld', 07:47:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:47:57 INFO - 'LOGNAME': 'cltbld', 07:47:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:57 INFO - 'MOZ_NO_REMOTE': '1', 07:47:57 INFO - 'NO_EM_RESTART': '1', 07:47:57 INFO - 'PAGER': '/bin/cat', 07:47:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:47:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:57 INFO - 'PWD': '/builds/slave/test', 07:47:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:47:57 INFO - 'SHELL': '/bin/bash', 07:47:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8XBfIcQGsH/Listeners', 07:47:57 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 07:47:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:47:57 INFO - 'USER': 'cltbld', 07:47:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:47:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:47:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:57 INFO - 'XPC_FLAGS': '0x0', 07:47:57 INFO - 'XPC_SERVICE_NAME': '0', 07:47:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:47:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:57 INFO - Downloading/unpacking psutil>=3.1.1 07:47:57 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 07:47:57 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 07:47:57 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 07:47:57 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 07:47:57 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 07:47:57 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 07:48:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:48:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:48:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:48:01 INFO - Installing collected packages: psutil 07:48:01 INFO - Running setup.py install for psutil 07:48:01 INFO - building 'psutil._psutil_osx' extension 07:48:01 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 07:48:02 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 07:48:02 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 07:48:02 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 07:48:02 INFO - building 'psutil._psutil_posix' extension 07:48:02 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 07:48:02 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:48:02 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:48:02 INFO - ^ 07:48:02 INFO - 1 warning generated. 07:48:02 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 07:48:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:48:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:48:02 INFO - Successfully installed psutil 07:48:02 INFO - Cleaning up... 07:48:02 INFO - Return code: 0 07:48:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:48:02 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')]} 07:48:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:48:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:02 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')]} 07:48:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:48:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:02 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 0x10af2f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aea5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f912b46c300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad43d30>, '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 0x10ab69db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad3bb20>, '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.pHfGeLPyoY/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.8XBfIcQGsH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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 07:48:02 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 07:48:02 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 07:48:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pHfGeLPyoY/Render', 07:48:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:48:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:48:02 INFO - 'HOME': '/Users/cltbld', 07:48:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:48:02 INFO - 'LOGNAME': 'cltbld', 07:48:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:02 INFO - 'MOZ_NO_REMOTE': '1', 07:48:02 INFO - 'NO_EM_RESTART': '1', 07:48:02 INFO - 'PAGER': '/bin/cat', 07:48:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:48:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:02 INFO - 'PWD': '/builds/slave/test', 07:48:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:48:02 INFO - 'SHELL': '/bin/bash', 07:48:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8XBfIcQGsH/Listeners', 07:48:02 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 07:48:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:48:02 INFO - 'USER': 'cltbld', 07:48:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:48:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:48:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:02 INFO - 'XPC_FLAGS': '0x0', 07:48:02 INFO - 'XPC_SERVICE_NAME': '0', 07:48:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:48:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:48:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:48:03 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 07:48:03 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 07:48:03 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 07:48:03 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 07:48:03 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 07:48:03 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 07:48:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:48:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:48:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:48:05 INFO - Installing collected packages: mozsystemmonitor 07:48:05 INFO - Running setup.py install for mozsystemmonitor 07:48:05 INFO - Successfully installed mozsystemmonitor 07:48:05 INFO - Cleaning up... 07:48:05 INFO - Return code: 0 07:48:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:48: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')]} 07:48:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:48:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48: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')]} 07:48:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:48:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10af2f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aea5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f912b46c300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad43d30>, '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 0x10ab69db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad3bb20>, '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.pHfGeLPyoY/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.8XBfIcQGsH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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 07:48: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==2.5.1'] in /builds/slave/test/build 07:48: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==2.5.1 07:48:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pHfGeLPyoY/Render', 07:48:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:48:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:48:05 INFO - 'HOME': '/Users/cltbld', 07:48:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:48:05 INFO - 'LOGNAME': 'cltbld', 07:48:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:05 INFO - 'MOZ_NO_REMOTE': '1', 07:48:05 INFO - 'NO_EM_RESTART': '1', 07:48:05 INFO - 'PAGER': '/bin/cat', 07:48:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:48:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:05 INFO - 'PWD': '/builds/slave/test', 07:48:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:48:05 INFO - 'SHELL': '/bin/bash', 07:48:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8XBfIcQGsH/Listeners', 07:48:05 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 07:48:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:48:05 INFO - 'USER': 'cltbld', 07:48:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:48:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:48:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:05 INFO - 'XPC_FLAGS': '0x0', 07:48:05 INFO - 'XPC_SERVICE_NAME': '0', 07:48:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:48:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:48:06 INFO - Downloading/unpacking jsonschema==2.5.1 07:48:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:48:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:48:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:48:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:48:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:48:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:48:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:48:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:48:08 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 07:48:08 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 07:48:08 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 07:48:08 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 07:48:08 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 07:48:08 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 07:48:09 INFO - Downloading functools32-3.2.3-2.tar.gz 07:48:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:48:09 INFO - warning: no files found matching '*.txt' 07:48:09 INFO - no previously-included directories found matching 'build' 07:48:09 INFO - no previously-included directories found matching 'dist' 07:48:09 INFO - no previously-included directories found matching '.git*' 07:48:09 INFO - Installing collected packages: jsonschema, functools32 07:48:09 INFO - Running setup.py install for functools32 07:48:09 INFO - warning: no files found matching '*.txt' 07:48:09 INFO - no previously-included directories found matching 'build' 07:48:09 INFO - no previously-included directories found matching 'dist' 07:48:09 INFO - no previously-included directories found matching '.git*' 07:48:09 INFO - Successfully installed jsonschema functools32 07:48:09 INFO - Cleaning up... 07:48:09 INFO - Return code: 0 07:48:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:48:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:48:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:48:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:48:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10af2f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aea5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f912b46c300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad43d30>, '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 0x10ab69db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad3bb20>, '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.pHfGeLPyoY/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.8XBfIcQGsH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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 07:48:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:48:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:48:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pHfGeLPyoY/Render', 07:48:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:48:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:48:09 INFO - 'HOME': '/Users/cltbld', 07:48:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:48:09 INFO - 'LOGNAME': 'cltbld', 07:48:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:09 INFO - 'MOZ_NO_REMOTE': '1', 07:48:09 INFO - 'NO_EM_RESTART': '1', 07:48:09 INFO - 'PAGER': '/bin/cat', 07:48:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:48:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:09 INFO - 'PWD': '/builds/slave/test', 07:48:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:48:09 INFO - 'SHELL': '/bin/bash', 07:48:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8XBfIcQGsH/Listeners', 07:48:09 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 07:48:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:48:09 INFO - 'USER': 'cltbld', 07:48:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:48:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:48:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:09 INFO - 'XPC_FLAGS': '0x0', 07:48:09 INFO - 'XPC_SERVICE_NAME': '0', 07:48:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:48:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:48:09 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:48:09 INFO - Cleaning up... 07:48:09 INFO - Return code: 0 07:48:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:48:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:48:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:48:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:48:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10af2f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aea5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f912b46c300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad43d30>, '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 0x10ab69db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad3bb20>, '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.pHfGeLPyoY/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.8XBfIcQGsH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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 07:48:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:48:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:48:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pHfGeLPyoY/Render', 07:48:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:48:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:48:09 INFO - 'HOME': '/Users/cltbld', 07:48:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:48:09 INFO - 'LOGNAME': 'cltbld', 07:48:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:09 INFO - 'MOZ_NO_REMOTE': '1', 07:48:09 INFO - 'NO_EM_RESTART': '1', 07:48:09 INFO - 'PAGER': '/bin/cat', 07:48:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:48:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:09 INFO - 'PWD': '/builds/slave/test', 07:48:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:48:09 INFO - 'SHELL': '/bin/bash', 07:48:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8XBfIcQGsH/Listeners', 07:48:09 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 07:48:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:48:09 INFO - 'USER': 'cltbld', 07:48:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:48:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:48:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:09 INFO - 'XPC_FLAGS': '0x0', 07:48:09 INFO - 'XPC_SERVICE_NAME': '0', 07:48:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:48:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:48:09 INFO - Downloading/unpacking blobuploader==1.2.4 07:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:48:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:48:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:48:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:48:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:48:12 INFO - Downloading blobuploader-1.2.4.tar.gz 07:48:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:48:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:48:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:48:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:48:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:48:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:48:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:48:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:48:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:48:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:48:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:48:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:48:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:48:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:48:13 INFO - Downloading docopt-0.6.1.tar.gz 07:48:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:48:13 INFO - Installing collected packages: blobuploader, requests, docopt 07:48:13 INFO - Running setup.py install for blobuploader 07:48:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:48:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:48:13 INFO - Running setup.py install for requests 07:48:14 INFO - Running setup.py install for docopt 07:48:14 INFO - Successfully installed blobuploader requests docopt 07:48:14 INFO - Cleaning up... 07:48:14 INFO - Return code: 0 07:48:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:48:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:48:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:48:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:48:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:48:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:14 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 0x10af2f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aea5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f912b46c300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad43d30>, '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 0x10ab69db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad3bb20>, '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.pHfGeLPyoY/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.8XBfIcQGsH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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 07:48:14 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 07:48:14 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 07:48:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pHfGeLPyoY/Render', 07:48:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:48:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:48:14 INFO - 'HOME': '/Users/cltbld', 07:48:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:48:14 INFO - 'LOGNAME': 'cltbld', 07:48:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:14 INFO - 'MOZ_NO_REMOTE': '1', 07:48:14 INFO - 'NO_EM_RESTART': '1', 07:48:14 INFO - 'PAGER': '/bin/cat', 07:48:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:48:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:14 INFO - 'PWD': '/builds/slave/test', 07:48:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:48:14 INFO - 'SHELL': '/bin/bash', 07:48:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8XBfIcQGsH/Listeners', 07:48:14 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 07:48:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:48:14 INFO - 'USER': 'cltbld', 07:48:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:48:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:48:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:14 INFO - 'XPC_FLAGS': '0x0', 07:48:14 INFO - 'XPC_SERVICE_NAME': '0', 07:48:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:48:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:48:14 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-OH6iLX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:48:14 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-XRayOf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:48:15 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-skrZpY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:48:15 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-VFUsie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:48:15 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-nIxoin-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:48:15 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-1okIYy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:48:15 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-qyDxsK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:48:15 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-Ul27Wq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:48:15 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-grm3gK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:48:15 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-lifDlO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:48:15 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-3VBWRU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:48:15 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-_pparX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:48:16 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-bSEw9X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:48:16 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-Yk7Qaq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:48:16 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-rqXNm7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:48:16 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-5lcvgC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:48:16 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-dOM4fC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:48:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:48:16 INFO - Running setup.py install for manifestparser 07:48:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:48:16 INFO - Running setup.py install for mozcrash 07:48:16 INFO - Running setup.py install for mozdebug 07:48:16 INFO - Running setup.py install for mozdevice 07:48:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:48:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:48:17 INFO - Running setup.py install for mozfile 07:48:17 INFO - Running setup.py install for mozhttpd 07:48:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:48:17 INFO - Running setup.py install for mozinfo 07:48:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:48:17 INFO - Running setup.py install for mozInstall 07:48:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:48:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:48:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:48:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:48:17 INFO - Running setup.py install for mozleak 07:48:17 INFO - Running setup.py install for mozlog 07:48:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:48:18 INFO - Running setup.py install for moznetwork 07:48:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:48:18 INFO - Running setup.py install for mozprocess 07:48:18 INFO - Running setup.py install for mozprofile 07:48:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:48:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:48:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:48:18 INFO - Running setup.py install for mozrunner 07:48:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:48:18 INFO - Running setup.py install for mozscreenshot 07:48:18 INFO - Running setup.py install for moztest 07:48:18 INFO - Running setup.py install for mozversion 07:48:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:48:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:48:19 INFO - Cleaning up... 07:48:19 INFO - Return code: 0 07:48:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:48:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:48:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:48:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:48:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:48:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:19 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 0x10af2f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aea5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f912b46c300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad43d30>, '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 0x10ab69db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad3bb20>, '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.pHfGeLPyoY/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.8XBfIcQGsH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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 07:48:19 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 07:48:19 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 07:48:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pHfGeLPyoY/Render', 07:48:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:48:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:48:19 INFO - 'HOME': '/Users/cltbld', 07:48:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:48:19 INFO - 'LOGNAME': 'cltbld', 07:48:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:19 INFO - 'MOZ_NO_REMOTE': '1', 07:48:19 INFO - 'NO_EM_RESTART': '1', 07:48:19 INFO - 'PAGER': '/bin/cat', 07:48:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:48:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:19 INFO - 'PWD': '/builds/slave/test', 07:48:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:48:19 INFO - 'SHELL': '/bin/bash', 07:48:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8XBfIcQGsH/Listeners', 07:48:19 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 07:48:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:48:19 INFO - 'USER': 'cltbld', 07:48:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:48:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:48:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:19 INFO - 'XPC_FLAGS': '0x0', 07:48:19 INFO - 'XPC_SERVICE_NAME': '0', 07:48:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:48:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:48:19 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-yDC6jW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:48:19 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)) 07:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:48:19 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-oPZphF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:48:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:48:19 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-XoBW5z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:48:19 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)) 07:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:48:19 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-H5gLoF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:48:19 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)) 07:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:48:19 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-ZFq9zd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:48:19 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)) 07:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:48:19 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-PeoqKx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:48:20 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)) 07:48:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:48:20 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-2pLdCU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:48:20 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)) 07:48:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:48:20 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-7CtLV9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:48:20 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)) 07:48:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:48:20 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-6Ag7hG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:48:20 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)) 07:48:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:48:20 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-xiA4Vv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:48:20 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)) 07:48:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:48:20 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-9mafMl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:48:20 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)) 07:48:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:48:20 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-GOhSdI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:48:20 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)) 07:48:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:48:20 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-LHZqcz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:48:20 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)) 07:48:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:48:20 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-d1c4Nw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:48:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:48:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:48:20 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-omjTyJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:48:21 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)) 07:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:48:21 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-H0I78y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:48:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:48:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:48:21 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-VOmvbO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:48:21 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)) 07:48:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:48:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:48:21 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)) 07:48:21 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)) 07:48:21 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)) 07:48:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:48:21 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 07:48:21 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 07:48:21 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 07:48:21 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 07:48:21 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 07:48:21 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 07:48:23 INFO - Downloading blessings-1.6.tar.gz 07:48:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:48:23 INFO - Installing collected packages: blessings 07:48:23 INFO - Running setup.py install for blessings 07:48:23 INFO - Successfully installed blessings 07:48:23 INFO - Cleaning up... 07:48:24 INFO - Return code: 0 07:48:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:48:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:48:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:48:24 INFO - Reading from file tmpfile_stdout 07:48:24 INFO - Current package versions: 07:48:24 INFO - blessings == 1.6 07:48:24 INFO - blobuploader == 1.2.4 07:48:24 INFO - docopt == 0.6.1 07:48:24 INFO - functools32 == 3.2.3-2 07:48:24 INFO - jsonschema == 2.5.1 07:48:24 INFO - manifestparser == 1.1 07:48:24 INFO - mozInstall == 1.12 07:48:24 INFO - mozcrash == 0.17 07:48:24 INFO - mozdebug == 0.1 07:48:24 INFO - mozdevice == 0.48 07:48:24 INFO - mozfile == 1.2 07:48:24 INFO - mozhttpd == 0.7 07:48:24 INFO - mozinfo == 0.9 07:48:24 INFO - mozleak == 0.1 07:48:24 INFO - mozlog == 3.4 07:48:24 INFO - moznetwork == 0.27 07:48:24 INFO - mozprocess == 0.23 07:48:24 INFO - mozprofile == 0.28 07:48:24 INFO - mozrunner == 6.12 07:48:24 INFO - mozscreenshot == 0.1 07:48:24 INFO - mozsystemmonitor == 0.3 07:48:24 INFO - moztest == 0.7 07:48:24 INFO - mozversion == 1.4 07:48:24 INFO - psutil == 3.1.1 07:48:24 INFO - requests == 1.2.3 07:48:24 INFO - wsgiref == 0.1.2 07:48:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:48:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:48:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:48:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:48:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:48:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:24 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 0x10af2f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aea5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f912b46c300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad43d30>, '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 0x10ab69db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad3bb20>, '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.pHfGeLPyoY/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.8XBfIcQGsH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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 07:48:24 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 07:48:24 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 07:48:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pHfGeLPyoY/Render', 07:48:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:48:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:48:24 INFO - 'HOME': '/Users/cltbld', 07:48:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:48:24 INFO - 'LOGNAME': 'cltbld', 07:48:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:24 INFO - 'MOZ_NO_REMOTE': '1', 07:48:24 INFO - 'NO_EM_RESTART': '1', 07:48:24 INFO - 'PAGER': '/bin/cat', 07:48:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:48:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:24 INFO - 'PWD': '/builds/slave/test', 07:48:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:48:24 INFO - 'SHELL': '/bin/bash', 07:48:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8XBfIcQGsH/Listeners', 07:48:24 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 07:48:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:48:24 INFO - 'USER': 'cltbld', 07:48:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:48:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:48:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:24 INFO - 'XPC_FLAGS': '0x0', 07:48:24 INFO - 'XPC_SERVICE_NAME': '0', 07:48:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:48:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:48:24 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)) 07:48:24 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)) 07:48:24 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)) 07:48:24 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)) 07:48:24 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)) 07:48:24 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)) 07:48:24 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)) 07:48:24 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)) 07:48:24 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)) 07:48:24 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)) 07:48:24 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)) 07:48:24 INFO - Cleaning up... 07:48:24 INFO - Return code: 0 07:48:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:48:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:48:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:48:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:48:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:48:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:24 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 0x10af2f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aea5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f912b46c300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad43d30>, '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 0x10ab69db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad3bb20>, '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.pHfGeLPyoY/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.8XBfIcQGsH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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 07:48:24 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 07:48:24 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 07:48:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pHfGeLPyoY/Render', 07:48:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:48:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:48:24 INFO - 'HOME': '/Users/cltbld', 07:48:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:48:24 INFO - 'LOGNAME': 'cltbld', 07:48:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:24 INFO - 'MOZ_NO_REMOTE': '1', 07:48:24 INFO - 'NO_EM_RESTART': '1', 07:48:24 INFO - 'PAGER': '/bin/cat', 07:48:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:48:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:24 INFO - 'PWD': '/builds/slave/test', 07:48:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:48:24 INFO - 'SHELL': '/bin/bash', 07:48:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8XBfIcQGsH/Listeners', 07:48:24 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 07:48:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:48:24 INFO - 'USER': 'cltbld', 07:48:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:48:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:48:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:24 INFO - 'XPC_FLAGS': '0x0', 07:48:24 INFO - 'XPC_SERVICE_NAME': '0', 07:48:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:48:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:48:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:48:24 INFO - Cleaning up... 07:48:24 INFO - Return code: 0 07:48:24 INFO - Running post-action listener: _resource_record_post_action 07:48:24 INFO - Running post-action listener: _start_resource_monitoring 07:48:24 INFO - Starting resource monitoring. 07:48:24 INFO - [mozharness: 2016-09-23 14:48:24.904272Z] Finished create-virtualenv step (success) 07:48:24 INFO - [mozharness: 2016-09-23 14:48:24.905317Z] Running install step. 07:48:24 INFO - Running pre-action listener: _resource_record_pre_action 07:48:24 INFO - Running main action method: install 07:48:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:48:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:48:25 INFO - Reading from file tmpfile_stdout 07:48:25 INFO - Detecting whether we're running mozinstall >=1.0... 07:48:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:48:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:48:25 INFO - Reading from file tmpfile_stdout 07:48:25 INFO - Output received: 07:48:25 INFO - Usage: mozinstall [options] installer 07:48:25 INFO - Options: 07:48:25 INFO - -h, --help show this help message and exit 07:48:25 INFO - -d DEST, --destination=DEST 07:48:25 INFO - Directory to install application into. [default: 07:48:25 INFO - "/builds/slave/test"] 07:48:25 INFO - --app=APP Application being installed. [default: firefox] 07:48:25 INFO - mkdir: /builds/slave/test/build/application 07:48:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:48:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 07:48:59 INFO - Reading from file tmpfile_stdout 07:48:59 INFO - Output received: 07:48:59 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:48:59 INFO - Running post-action listener: _resource_record_post_action 07:48:59 INFO - [mozharness: 2016-09-23 14:48:59.811267Z] Finished install step (success) 07:48:59 INFO - [mozharness: 2016-09-23 14:48:59.811425Z] Running run-tests step. 07:48:59 INFO - Running pre-action listener: _resource_record_pre_action 07:48:59 INFO - Running main action method: run_tests 07:48:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:48:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:48:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:48:59 INFO - 2016-09-23 07:48:59.825 screenresolution[1644:8614] starting screenresolution argv=screenresolution get 07:48:59 INFO - 2016-09-23 07:48:59.828 screenresolution[1644:8614] Display 0: 1600x1200x32@60 07:48:59 INFO - 2016-09-23 07:48:59.834 screenresolution[1645:8616] starting screenresolution argv=screenresolution list 07:48:59 INFO - Available Modes on Display 0 07:48:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:48:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:48:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:48:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:49:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:49:00 INFO - Intel Iris: 07:49:00 INFO - Chipset Model: Intel Iris 07:49:00 INFO - Type: GPU 07:49:00 INFO - Bus: Built-In 07:49:00 INFO - VRAM (Dynamic, Max): 1536 MB 07:49:00 INFO - Vendor: Intel (0x8086) 07:49:00 INFO - Device ID: 0x0a2e 07:49:00 INFO - Revision ID: 0x0009 07:49:00 INFO - Displays: 07:49:00 INFO - Display: 07:49:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:49:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:49:00 INFO - Display Serial Number: 1600x1200 60 07:49:00 INFO - Main Display: Yes 07:49:00 INFO - Mirror: Off 07:49:00 INFO - Online: Yes 07:49:00 INFO - Rotation: Supported 07:49:00 INFO - Return code: 0 07:49:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:49:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:49:00 INFO - Python 2.7.3 07:49:00 INFO - Return code: 0 07:49:00 INFO - grabbing minidump binary from tooltool 07:49: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')]} 07:49:00 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 0x10ad43d30>, '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 0x10ab69db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad3bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:49:00 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 07:49:00 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 07:49:00 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 07:49:00 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:49:00 INFO - Return code: 0 07:49:00 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:49:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:49:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:49:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:49:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:49:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/O0qTAEdFQDCpgJqGmIJgow/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0074', '--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 07:49:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/O0qTAEdFQDCpgJqGmIJgow/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0074 --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 07:49:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pHfGeLPyoY/Render', 07:49:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:49:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:49:00 INFO - 'HOME': '/Users/cltbld', 07:49:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:49:00 INFO - 'LOGNAME': 'cltbld', 07:49:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:49:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:49:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:49:00 INFO - 'MOZ_NO_REMOTE': '1', 07:49:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:49:00 INFO - 'NO_EM_RESTART': '1', 07:49:00 INFO - 'PAGER': '/bin/cat', 07:49:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:49:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:49:00 INFO - 'PWD': '/builds/slave/test', 07:49:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:49:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:49:00 INFO - 'SHELL': '/bin/bash', 07:49:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8XBfIcQGsH/Listeners', 07:49:00 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 07:49:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:49:00 INFO - 'USER': 'cltbld', 07:49:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:49:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:49:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:49:00 INFO - 'XPC_FLAGS': '0x0', 07:49:00 INFO - 'XPC_SERVICE_NAME': '0', 07:49:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:49:00 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/O0qTAEdFQDCpgJqGmIJgow/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0074', '--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 07:49:00 INFO - mozversion application_buildid: 20160923065658 07:49:00 INFO - mozversion application_changeset: e26037d2a25382b8b8a70d6b0390dc1cbe370f5b 07:49:00 INFO - mozversion application_display_name: Nightly 07:49:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:49:00 INFO - mozversion application_name: Firefox 07:49:00 INFO - mozversion application_remotingname: firefox 07:49:00 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 07:49:00 INFO - mozversion application_vendor: Mozilla 07:49:00 INFO - mozversion application_version: 52.0a1 07:49:00 INFO - mozversion platform_buildid: 20160923065658 07:49:00 INFO - mozversion platform_changeset: e26037d2a25382b8b8a70d6b0390dc1cbe370f5b 07:49:00 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 07:49:00 INFO - mozversion platform_version: 52.0a1 07:49:00 INFO - using testdate: 1474642140 07:49:00 INFO - actual date: 1474642140 07:49:00 INFO - starting webserver on 'localhost:49272' 07:49:00 INFO - SUITE-START | Running 2 tests 07:49:00 INFO - TEST-START | dromaeo_css 07:49:00 INFO - operating with platform_type : mac_ 07:49:00 INFO - Initialising browser for dromaeo_css test... 07:49:00 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/tmpcmS8jn/profile http://localhost:49272/getInfo.html) 07:49:02 INFO - PROCESS | 1655 | __metrics Screen width/height:1600/1200 07:49:02 INFO - PROCESS | 1655 | colorDepth:24 07:49:02 INFO - PROCESS | 1655 | Browser inner width/height: 1024/689 07:49:02 INFO - PROCESS | 1655 | __metrics 07:49:03 INFO - PROCESS | 1655 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:49:03 INFO - PROCESS | 1655 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:49:03 INFO - TEST-INFO | 1655: exit 0 07:49:03 INFO - Browser initialized. 07:49:03 INFO - Running cycle 1/1 for dromaeo_css test... 07:49:03 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/tmpcmS8jn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:49:15 INFO - PROCESS | 1658 | RSS: Main: 235782144 07:49:15 INFO - PROCESS | 1658 | 07:50:06 INFO - PROCESS | 1658 | 1474642206461 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:52:18 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 07:52:19 INFO - PROCESS | 1658 | RSS: Main: 356777984 07:52:19 INFO - PROCESS | 1658 | 07:55:23 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 07:55:23 INFO - PROCESS | 1658 | RSS: Main: 370696192 07:55:23 INFO - PROCESS | 1658 | 07:58:26 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 07:58:26 INFO - PROCESS | 1658 | RSS: Main: 341282816 07:58:26 INFO - PROCESS | 1658 | 08:01:29 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 08:01:29 INFO - PROCESS | 1658 | RSS: Main: 342798336 08:01:29 INFO - PROCESS | 1658 | 08:04:33 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 08:04:34 INFO - PROCESS | 1658 | RSS: Main: 338386944 08:04:34 INFO - PROCESS | 1658 | 08:07:37 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 08:07:37 INFO - PROCESS | 1658 | RSS: Main: 408764416 08:07:37 INFO - PROCESS | 1658 | 08:07:37 INFO - PROCESS | 1658 | __start_tp_report 08:07:37 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 08:07:37 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 08:07:37 INFO - PROCESS | 1658 | |i|pagename|runs| 08:07:37 INFO - PROCESS | 1658 | |0;dojo.html;3270.5094235864617;3282.606087269527;3329.7669163158575;3343.1976325681844;3376;5505.146702261146;5540.833774986747;5570.721463926808;5596.63621864579;5620.831375058745;5548.4174161713045;5590.329160500735;5601.047821870282;5636.718164091789;5648.717564121788;5116.155834287338;5147.819826306089;5179.637425380225;5184.196449550326;5184.637075404723;4363.498197707273;5058.721770302632;5158.148905430599;5211.557017653485;5228.529432351088;5212.374515058198;5221.62533543765;5231.555317797992;5238.52853243208;5242.423333433319;5077.517635824591;5102.795888164469;5116.488351164891;5170.612204084671;5212.739363031871;5111.821086261963;5113.82101626445;5159.993801208766;5168.9741551292;5221.373435187764;5572.637778544382;5605.831825045255;5625.5218306444;5638.746256418471;5643.5767317451355;5976.581639285252;6161.229846269216;6163.322034576193;6167.506599472032;6183.81448556544;6101.755929762849;6121.755129794803;6126.8774624507705;6133.610107582703;6143.262808463013;5644.802431914945;5649.209110724501;5660.716964151776;5687.488126068673;5772.076467765138;6120.540959428061;6276.686165691697;6276.937230627726;6304.495640348853;6309.116723658692;5857.179994800731;5916.526677865761;6055.031195008777;6063.96912524863;6070.575059745775;6055.636661800306;6106.847328816815;6107.006761825686;6114.236541168675;6170.568060235741;6134.631922084689;6142.170806941095;6144.78493252734;6145.139680444741;6150.985087460519;5993.610415323077;6175.660338681326;6185.165002724574;6189.473894718909;6196.349383314777;4811.206150985048;4812.927806082912;4853.247746599212;4857.611391088704;4858.902821943541;4358.259095953696;4371;4381.430414046154;4393.18726035678;4414.315781053878;5667.433256674382;5692.260006199168;5694.345150307768;5697.202391665171;5706.514946229534;6052.213212282375;6116.853194528077;6118.862843289934;6143.109249158847;6171.6297022178815;5698.886022279614;5714.0571805652435;5716.142578613241;5716.885662286731;5717.914231286451;5328.813491527778;5347.465253474621;5356.250124982505;5359.249705041298;5362.651427657268;6175.876482470236;6183.196184496167;6220.875582488235;6283.08895210192;6296.33888441707;6139.2161661365335;6195.1636529068;6207.348228435949;6215.223097112861;6223.066540019034;6225.782097626561;6245.5628106033955;6261.24865016201;6276.1213430118905;6321.462675672436;5946.613470124428;6007.12896629995;6071.119687645355;6075.058365953284;6079.209702738615;6108.372425856702;6129.601575897553;6181.196444462191;6204.720787564661;6233.283172435228;6012.518998480198;6013.278406591237;6029.879402412015;6059.878802423838;6075.392460754066;5093.592512598909;5989.401059893976;6004.42957918997;6007.429294217042;6017.699115044318;4904.607631389552;5324.254604355471;5749.91375129365;5817.738201780845;5840.649561026352;5974.641521508724;5997.520198384206;6014.729337179925;6021.277446706424;6035.758569657341;5650.208970744181;5716.657000579979;5724.4561766632105;5796.507296879644;5828.184054232326 08:07:37 INFO - PROCESS | 1658 | |1;ext.html;469.48825779899903;498.8553319537334;513.9537441630254;525.5427777833286;526.6260954722145;27713;30784.84607576962;40152.397714034276;41128.79435602825;41178;41271.38092928608;43442.56557434425;43497.78251108748;43498.782506087424;43572.78213608928;8698.434601750865;9580.377275477107;9753.21974242059;9762.07260310273;9780.951095244514;8741.169588889044;11836.881631183707;12079.818802717966;12090.214136081171;12140;11563.421828908564;11844.7631047379;11924.403779811018;11960.102992275572;11993.64019079429;11748.941255293712;11820.88179118215;11829.822552661717;11836.822447663291;11864.406779661025;11534.307941523452;11736.647900562997;11762.882371176263;11775.470103845348;11783.116266279978;39870.601293986976;40207;40219;40247.99380015494;40255.59744402577;3329.667033296675;3373.308471763283;3439.4496880499;3459.584849818038;3915.353966595508;29609;30980.38039239225;30985.76056957719;31013.689863101306;31141.688583114104;3226.4998925166637;3259.26666500038;3349.7271037006026;3379.2734562069027;3379.8141102239365;359041;363606;363842;363998;365593.1720341408;61487.692561536904;61826;62043.759124817254;62122.689386552775;62143.13570592889;64835;65268;65372.67313663401;65455.01817472742;65529;16092.275847586887;16291.941023833413;16324.918375408048;16342.264598093114;16349.34602615882;11382.54469821198;11602.245854019462;11614.477348519336;12563.371831408393;12635.93682031584;17340.826591734174;17372;17492.82507174912;17559.912200438917;17641.117944102745;5937.324931707853;6017.194841547605;6026.638401695912;6033.7586496540525;6051.092336149525;710.3180946291618;819.5779173725537;871.7820544863785;945.9877930614176;953.6233187890745;29098.7090129096;29135.417291654474;29178.562321565194;29866.850665746533;29992.55011174834;1035.694470131313;1063.0538820449806;1066.6373433032807;1081.4754843900703;1168.684455197109;15100.54698359051;15643.608909777347;15653.921730391503;15720;16045.759313610306;187825.18262226076;189169;189479;189725.05137474224;190334.04832975747;58515;58741.82516349734;58861;58915.821683566086;58994;1188.4889497515978;1216.403962058585;1305.3408028945512;1320.6962398648366;1342.8657134286493;23523;29628.407431851672;29822.701772981993;31088.22279443032;31181.8440907794;50009;50373.97756134644;50591.241131383795;50607.240891387395;50751;427672;429280;431268;432458;432614;25772.226833195033;25774;26120.477590448463;26388.868055659597;26785;46707.53292467032;47083.29375059308;47534.762326188145;47849;48067.038659225924;38368.2326353477;38550.22899541938;38554.421683675326;39593.01017474586;40262.39606405848;38305;38691.613083868804;39320.41019384655;39934;40169.59830401659;37726.245475089796;38453.80773096228;38515.807420963836;38733.80633096817;38829.61170388373;28190;30824;34115.488267676505;34189.14462178019;34300.31399372048;25196;25215.49569008573;25526.23421297364;25608.35979100463;25627.846746896063 08:07:37 INFO - PROCESS | 1658 | |2;jquery.html;314.72776048717856;349.6468566747584;368.42893515051645;370.6904734546653;405.07036351573134;15292.694146117072;15549.74186553134;18184.45446636603;19694.113764880578;19848.503787405323;19487.805121948775;19498.70751938722;19549.804501954975;19607.725497842664;19622;5575.215930902113;5777.537796976253;5851.385604511529;5904.616199947011;5908.556858235628;3563.6080031196548;5524.922640085165;5794.333651630074;5892.734826932777;5910.527157827385;4260.31834906415;4304.24675681756;6481.254655714582;6562.179727534059;6573.638449885254;6250.1874756281395;6457.515686323498;6569.441597464197;6573.737050517973;6577.506686998447;5393.541548968343;5580.832575022756;5596.6362186458155;5605.411431799643;5622.887542249132;20686.482837929023;21338.466538336666;23800.166994155123;24736.876315618305;25036;2022.1203776357331;2177.2706143441965;2229.788170123852;2298.0348253733473;3009.292816188194;8507.404481686284;9982.900170998342;10184.94907525465;13366.930645548333;13754.31228438584;1710.529604358799;1811.194018661696;1835.9173837177225;1859.2098358197848;1914.9808501915081;122755.3862230692;124087;126301;126520;128554.07168892381;10773.676789696321;11065;11116.110711143088;11125.82384362082;11258.43707814606;12195.268283902995;12658.873411265953;12685.429155688016;12936.800743873564;12964.80552791709;7602.657880395395;7606.315431611071;7667.271609197117;8063.072746634095;8177.182281771894;7688.615569221516;7986.361091112697;8085.595720213966;8246.463979841292;8264.917350826536;4341.283688191476;4344.304911214191;4402.823887044547;4421.204183246982;4438.533953934855;1729.1181497436398;1764.514758441439;1810.9275628974694;1820.4720631016858;1825.415866922572;899.1862364560084;907.2016625369764;916.4180745226829;942.5004747483845;975.9463229522303;19642.312519061765;20223.08996095179;20234.494137646678;20284.695729564068;20448.514594680906;920.2545937790411;972.6838777397375;992;1011.2112552209288;1013.0983424751977;10168.339057961357;10558.366498010144;10615.363078215332;10677.199210059276;10700.892991070144;428865;436215;436401;580865;586867;143338;148348;151357;152820;154437.22781386247;918.4122161816442;937.8077494113691;972.6109556177586;981.9214462842956;983.4836710726926;14153.603529417767;16585.253663584925;18484.260629574666;18549.979751113817;18849.434516964513;43321;53928.73035634954;54518.55110426855;54693.453065468835;55478.44521554894;79156.3349864019;80677;81113;81544.70170694495;82420.58789706013;6609.636469994197;7555.244475552401;7975.361971042419;8146.674133034612;8166.142555031636;11301.547938082385;12480.563180288646;12517.687057823627;12799.872001279868;12925.482980680668;10930.180236482136;11085.667429977113;11121.666350009513;11143.108551315712;11302.982731554199;8398.412111152405;8973.37186396972;10819.404932728776;11104.722381940515;11133.05369043608;11127.221094523306;11143.498542565441;11189.664310070712;11257.71855703614;11448.542058317575;6714.697838597177;8011.479253848481;8022.719204827803;8035.236652518001;8262.049864265686;10008.84986725185;10637.840432393365;10786.784264314827;10848.783024339627;10913.618023369145 08:07:37 INFO - PROCESS | 1658 | |3;mootools.html;1355.2139758939813;1491.880649548036;1598.4804938395025;1839.5125291797667;1884.3404808317082;8464.153584641534;8930.776730581738;8931.330150238726;8960.507172105532;8978.147076027775;7774.92225077749;8082.838343233132;8098.757037288876;8470.364722645796;8720.302375809935;2381.4760752634393;2404.627282771173;2407.590709579367;2410.13235235316;2410.216679579135;2366;2380.833341666084;2418.2382549496942;2418.4316685578965;2419.7338292787867;2096.7693553709078;2181.7818218178213;2188.3106821351303;2335.4511689752894;2415.7825795678386;2389.8446600970883;2408.458096928177;2410.4817464245184;2414.1550457339968;2418.2745176446997;2172.728953562168;2292.484191056999;2367.7040369953756;2403.6034054381007;2407.6990376202975;8728.563571821447;8808.28238493494;8878.86681699775;8888.73333799987;8906.109389061106;5209.348831396075;5312.442193569658;5379.300690910196;5391.81128660495;5394.541463975567;3447.7586568940183;3525.541679581638;3667.064898450878;3669.7798132112157;3674.3018826422895;1085.7925538538166;1090.8745494268182;1099.2580008494315;1106.5463160104398;1109.046220250584;11562.132840036948;11779.882201177965;11780.998615117725;11788.351640659761;11796.52813887452;4545.522720114341;4658.138244424792;4768.809247630125;4781.402324709411;4789.640776941744;10091.646792362379;10093.495325233709;10094.49527523621;10095.293329466867;10107.09036186732;5345.919811202835;5363.19552067193;5364.114921037985;5366.463353664602;5369.919451208235;3683.7053035757076;4913.533214344631;4922.384701912261;4922.827701030446;4930.580900623416;3677.7425580209665;3702.648248416396;3737.4954381158195;3758.6053464385845;3764.228333191689;1145.7823013627385;1146.6158836789602;1160.5879912631062;1160.8490896183441;1167.3404526442532;623.4856243599049;764.694122351064;904.3127223310331;904.3262769236829;954.5704433005176;5810.82567522975;5921.73352199152;6074.787382441682;6124.938750612526;6130.915488733763;770.5569297653872;941.1576638908139;964.2382517810851;968.1722127580957;1007.1640538353149;3536.982315088408;3886.095813051584;3919.510061242345;3936.626020528045;4057.69567282455;8648.610812513452;10751.83872241917;10769.62306319275;10772.922707729322;10801.945990269998;10760.031597156138;10761.24671273019;10763;10772.838407423895;10779.407132607625;7782.260685234894;8086.110527841933;8110.107888132301;8112.22933821286;8139.959300203461;5634.6337488063145;5913.586048976703;5947.197128387786;6083.726232319467;6130.356312587114;9651.517424128906;9918.20654347636;9940.403575785476;9945.950270248602;9992.65025724096;9637.759056023655;10024.24818138657;10046.849297260693;10047.09576138151;10068.697939061547;8123.5532045738055;8151.225633564802;8317.95841020791;8319.126491718525;8329;7904.84190316202;8199.795005124919;8278.296344810758;8295.129011453952;8354.289885359813;6831.043653888559;6832.282610326043;6878;7291.671874765542;7428.071491063617;6118.235220597426;7168.67740951648;7239.529430586995;7303.379212766762;7461.515001524884;6771.255161932282;6946.16646002483;6954.9915262287695;6956.339147780953;6960.547564408297;4845.289025967538;4984.277279794482;5056.963322518948;5119.129747942784;5123.743812809419;4548.727076375428;4982.626303027215;5084.135696931457;5132.743362831919;5275.868103297448 08:07:37 INFO - PROCESS | 1658 | |4;prototype.html;299.38327046284667;299.6209794609818;308.1541169489751;315.5109580150766;316.43516323362803;5263.631545791796;5322.6008049396305;5353.89292214156;5362.597805164609;5381.81163659272;4034.354503279476;5039.899202015958;5079.898402031957;5120.569218623522;5323.148296272597;3561.5013898054294;3602.9819850900776;3900.278448487025;4000.1999600079953;4081.693872959525;3514.9648503514895;4024.7182697211206;4024.7182697211206;4051.210014047262;4072.511298644167;3912.784796836173;3984.3027470192746;3992.6606238469767;4005;4057.127717540728;3444.207832198583;3967.988163018441;4003.5996400360023;4047.7368971017086;4063.349864021757;2919.9124026279246;3263.7225835803984;3514.1741690702665;3517.8768743094124;3528.7177025837873;5152.227165925104;5189.117849965515;5195.818146364897;5197.714125723083;5199.6360254782185;4126.855560055384;4222.408862759216;4267.765272909989;4514.525974772634;4568.2462393705;4438.622717069053;5086.847394578169;5557.166425036236;5561.916571251434;5669.461401166883;3200.2159470929537;3366.4277072897667;3667.899630110956;3791.0901383667997;3816.7709937403843;5514.862128446781;5792.652440853562;5794.188813566104;5832.387599302097;5833.445822646841;3449.844756985942;3514.9420004595654;3700.5374328208973;3812.6187381262207;3813.771173729585;3885.922281554353;3897.4348719435525;3909.179072394772;3911.159100793343;3923.9215215695526;3504.56192975878;3865.342891708416;4003.3594624859884;4561.794719237642;4697.121151539343;4640.466346370143;5007.549320561167;5577.888442231214;5602.663840169603;5608.037186984604;1118.4463690473106;1307.7123032932739;1318.6241921052454;1338.631876234024;1340.2829486224823;830.8213734047088;848.8429640516524;856.2850020233051;872.3457406944791;885.9014821621272;4201.411802347674;4671.929921051187;4824.927626085611;5058.861756104847;5190.532852043334;5043.823466178666;5666.9716651416475;5691.601587888891;5738.340090889517;5766;4748.905021899612;4881.438634557071;5096.541311281928;5121.180611102206;5143.5113664201845;2789.916302510928;2974.1708849057673;2979.61265035544;2992.685767994329;2994.82031078136;4967.5529202371235;5534.446555344433;5607.80372686954;5785.508231800344;5934.8813023739285;5000.949990500121;5109.846704598868;5727.971360143172;5747.683877386784;5795.594308398456;5239.633225674166;5372.650777699437;5571.526420254324;5808.361080281165;5894.941050589525;4068.8169032394208;4522.479914809707;5251.632385732962;5411.350637923317;5759.7408116634015;4847.61219102478;4983.775730092227;5195.506426889439;5724.742386592697;5725.255716756795;5343.946560534345;5509.449055094458;5808.912866306924;6010.368911264429;6072.787452439144;3459.6194418613427;3589.2462582857893;3657.9940516358215;3796.8291426885303;3806.1436176859984;5482.671039737628;5709.858802948894;5746.27052150242;5761.654300741969;5772.884542309214;4673.719576825401;5591.608587399006;5623.8875222496135;5632.225848857761;5649.491545760901;4771.618270538418;4944.258361245842;5215.29593504872;5621.690807005491;5666.631668941505;4603.332516785114;4768.305907162442;5483.7806487740045;5505.6421332614855;5523.502884740393;5165.60528657268;5405.78376864921;5565.578973146694;5692.260006199168;5694.316681998187;4766.213574760264;5130.51260130287;5215.956808638211;5319.494648008433;5588.273524441796 08:07:37 INFO - PROCESS | 1658 | |5;yui.html;618.7988903606328;688.7781609821029;759.7454852624367;781.9482795639863;815.9845182399473;15434.845651543495;16017.599560011005;16058.197090145475;16060.277287522074;16102.597435064115;14038.649033774136;14364.425422983095;14476.5657030289;14477.5656730298;14494.927525362358;678.4368973751799;696.1715558485412;825.1253671108644;852.791066188783;853.3045567862173;860.565414465694;862.7411776467035;864.8227113441761;868.3834477520968;868.6091258933506;921;921.7741653294919;923.4090182283311;926.9710621210451;927.679950417105;716.8924661300795;734.8860926556392;884.3058199313572;918.9862152067724;920.6087412849579;671.711164199394;671.9865602687968;672.5930811858804;674.8650269945981;675.8884784010633;15269.236538173047;15271.923640381838;15289.923550382287;15295.694086118216;15302.540923772305;13499.932500337534;13701.177929324273;13754.105983111165;13759.17444953306;13911.010737350856;12185.147039707224;12310.26138431697;12310.75378492425;12354.320512371816;12852.807207891889;4399.944013436752;4427.9557204427865;4488.685791994561;4566.246569316058;4651.116287905287;86831;102517.4874125632;112789;114332;120266.19600705996;10511.26421150512;10525.157987360994;10556.208284378703;10573.788524229472;10976.945115274531;21807.67288490642;21818.454538636663;21920;21946;22203.66694499584;6607.669616519155;7816.960915195387;7835.255650713173;7874;7957.960210198912;4312.202242585132;4407.515173330931;4415.072834704748;4578.587927086578;4648.488666246778;3425.4519276915576;3559.9644003559633;3568.7680300780366;3570.6072332043454;3580.3018411410044;656.6552559905992;679.2053297641771;684.7397988764337;688.3942130924754;688.6591137387026;531.6491115863512;532.8454748123;588.9204957330705;604.3925854516183;651.7686221391433;8658.39391242607;8902;8980.55097245135;10032.799344013225;10234.283600147919;602.8553147244718;636.8662580858072;642.6626021338834;650.9088727578143;695.819087037374;4467.508574056851;4673.485916549177;4696.8590942271785;4727;4727.338172655831;155613.2219338896;157005;157333;161660;167325;131790;136715;138295;139297.30351348178;141123;96935;118886;119264;122119.38940305597;124437.37781311036;8926.955365223132;9034.45793252407;9075.183233509017;9091.090890910857;9096.1813436791;62311.688441557504;62815;63114.42626884803;63863;64042.359576403636;80554;91859;99109.50445247728;99398;102007.4899625497;11248.212625116163;11629.127815413709;11843.407829608657;11977.001767180367;12123.757524849278;12777.361131943551;12895.655373355281;12943.5469758558;13067.085304028627;13150.671233219246;10838.945805270923;11869.109816763605;12197.902188803051;12478.251304921734;12657.177283476545;11821.82267266009;12075.456604452997;12209.084318676312;12337.259764414164;12524.311162886128;11484.712882178012;11763.823542646696;11945.4027298633;12586.811197831857;13031.67692238511;10464.686059417925;11250.718732031764;11293.208117550663;11705.488353494087;11948.462319195483;10787.460626968777;11225.15811314171;11423.200375973935;11660.766784664429;11673.12451566153 08:07:37 INFO - PROCESS | 1658 | __end_tp_report 08:07:37 INFO - PROCESS | 1658 | __start_cc_report 08:07:37 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,1141 08:07:37 INFO - PROCESS | 1658 | __end_cc_report 08:07:37 INFO - PROCESS | 1658 | __startTimestamp1474643257486__endTimestamp 08:07:37 INFO - PROCESS | 1658 | 08:07:37 INFO - PROCESS | 1658 | ------- Summary: start ------- 08:07:37 INFO - PROCESS | 1658 | Number of tests: 6 08:07:37 INFO - PROCESS | 1658 | 08:07:37 INFO - PROCESS | 1658 | [#0] dojo.html Cycles:165 Average:5652.35 Median:5796.51 stddev:634.41 (10.9%) stddev-sans-first:608.21 08:07:37 INFO - PROCESS | 1658 | Values: 3270.5 3282.6 3329.8 3343.2 3376.0 5505.1 5540.8 5570.7 5596.6 5620.8 5548.4 5590.3 5601.0 5636.7 5648.7 5116.2 5147.8 5179.6 5184.2 5184.6 4363.5 5058.7 5158.1 5211.6 5228.5 5212.4 5221.6 5231.6 5238.5 5242.4 5077.5 5102.8 5116.5 5170.6 5212.7 5111.8 5113.8 5160.0 5169.0 5221.4 5572.6 5605.8 5625.5 5638.7 5643.6 5976.6 6161.2 6163.3 6167.5 6183.8 6101.8 6121.8 6126.9 6133.6 6143.3 5644.8 5649.2 5660.7 5687.5 5772.1 6120.5 6276.7 6276.9 6304.5 6309.1 5857.2 5916.5 6055.0 6064.0 6070.6 6055.6 6106.8 6107.0 6114.2 6170.6 6134.6 6142.2 6144.8 6145.1 6151.0 5993.6 6175.7 6185.2 6189.5 6196.3 4811.2 4812.9 4853.2 4857.6 4858.9 4358.3 4371.0 4381.4 4393.2 4414.3 5667.4 5692.3 5694.3 5697.2 5706.5 6052.2 6116.9 6118.9 6143.1 6171.6 5698.9 5714.1 5716.1 5716.9 5717.9 5328.8 5347.5 5356.3 5359.2 5362.7 6175.9 6183.2 6220.9 6283.1 6296.3 6139.2 6195.2 6207.3 6215.2 6223.1 6225.8 6245.6 6261.2 6276.1 6321.5 5946.6 6007.1 6071.1 6075.1 6079.2 6108.4 6129.6 6181.2 6204.7 6233.3 6012.5 6013.3 6029.9 6059.9 6075.4 5093.6 5989.4 6004.4 6007.4 6017.7 4904.6 5324.3 5749.9 5817.7 5840.6 5974.6 5997.5 6014.7 6021.3 6035.8 5650.2 5716.7 5724.5 5796.5 5828.2 08:07:37 INFO - PROCESS | 1658 | 08:07:37 INFO - PROCESS | 1658 | [#1] ext.html Cycles:180 Average:50297.41 Median:34152.32 stddev:90712.30 (265.6%) stddev-sans-first:90889.62 08:07:37 INFO - PROCESS | 1658 | Values: 469.5 498.9 514.0 525.5 526.6 27713.0 30784.8 40152.4 41128.8 41178.0 41271.4 43442.6 43497.8 43498.8 43572.8 8698.4 9580.4 9753.2 9762.1 9781.0 8741.2 11836.9 12079.8 12090.2 12140.0 11563.4 11844.8 11924.4 11960.1 11993.6 11748.9 11820.9 11829.8 11836.8 11864.4 11534.3 11736.6 11762.9 11775.5 11783.1 39870.6 40207.0 40219.0 40248.0 40255.6 3329.7 3373.3 3439.4 3459.6 3915.4 29609.0 30980.4 30985.8 31013.7 31141.7 3226.5 3259.3 3349.7 3379.3 3379.8 359041.0 363606.0 363842.0 363998.0 365593.2 61487.7 61826.0 62043.8 62122.7 62143.1 64835.0 65268.0 65372.7 65455.0 65529.0 16092.3 16291.9 16324.9 16342.3 16349.3 11382.5 11602.2 11614.5 12563.4 12635.9 17340.8 17372.0 17492.8 17559.9 17641.1 5937.3 6017.2 6026.6 6033.8 6051.1 710.3 819.6 871.8 946.0 953.6 29098.7 29135.4 29178.6 29866.9 29992.6 1035.7 1063.1 1066.6 1081.5 1168.7 15100.5 15643.6 15653.9 15720.0 16045.8 187825.2 189169.0 189479.0 189725.1 190334.0 58515.0 58741.8 58861.0 58915.8 58994.0 1188.5 1216.4 1305.3 1320.7 1342.9 23523.0 29628.4 29822.7 31088.2 31181.8 50009.0 50374.0 50591.2 50607.2 50751.0 427672.0 429280.0 431268.0 432458.0 432614.0 25772.2 25774.0 26120.5 26388.9 26785.0 46707.5 47083.3 47534.8 47849.0 48067.0 38368.2 38550.2 38554.4 39593.0 40262.4 38305.0 38691.6 39320.4 39934.0 40169.6 37726.2 38453.8 38515.8 38733.8 38829.6 28190.0 30824.0 34115.5 34189.1 34300.3 25196.0 25215.5 25526.2 25608.4 25627.8 08:07:37 INFO - PROCESS | 1658 | 08:07:37 INFO - PROCESS | 1658 | [#2] jquery.html Cycles:180 Average:32653.28 Median:24886.44 stddev:85564.18 (343.8%) stddev-sans-first:85769.76 08:07:37 INFO - PROCESS | 1658 | Values: 314.7 349.6 368.4 370.7 405.1 15292.7 15549.7 18184.5 19694.1 19848.5 19487.8 19498.7 19549.8 19607.7 19622.0 5575.2 5777.5 5851.4 5904.6 5908.6 3563.6 5524.9 5794.3 5892.7 5910.5 4260.3 4304.2 6481.3 6562.2 6573.6 6250.2 6457.5 6569.4 6573.7 6577.5 5393.5 5580.8 5596.6 5605.4 5622.9 20686.5 21338.5 23800.2 24736.9 25036.0 2022.1 2177.3 2229.8 2298.0 3009.3 8507.4 9982.9 10184.9 13366.9 13754.3 1710.5 1811.2 1835.9 1859.2 1915.0 122755.4 124087.0 126301.0 126520.0 128554.1 10773.7 11065.0 11116.1 11125.8 11258.4 12195.3 12658.9 12685.4 12936.8 12964.8 7602.7 7606.3 7667.3 8063.1 8177.2 7688.6 7986.4 8085.6 8246.5 8264.9 4341.3 4344.3 4402.8 4421.2 4438.5 1729.1 1764.5 1810.9 1820.5 1825.4 899.2 907.2 916.4 942.5 975.9 19642.3 20223.1 20234.5 20284.7 20448.5 920.3 972.7 992.0 1011.2 1013.1 10168.3 10558.4 10615.4 10677.2 10700.9 428865.0 436215.0 436401.0 580865.0 586867.0 143338.0 148348.0 151357.0 152820.0 154437.2 918.4 937.8 972.6 981.9 983.5 14153.6 16585.3 18484.3 18550.0 18849.4 43321.0 53928.7 54518.6 54693.5 55478.4 79156.3 80677.0 81113.0 81544.7 82420.6 6609.6 7555.2 7975.4 8146.7 8166.1 11301.5 12480.6 12517.7 12799.9 12925.5 10930.2 11085.7 11121.7 11143.1 11303.0 8398.4 8973.4 10819.4 11104.7 11133.1 11127.2 11143.5 11189.7 11257.7 11448.5 6714.7 8011.5 8022.7 8035.2 8262.0 10008.8 10637.8 10786.8 10848.8 10913.6 08:07:37 INFO - PROCESS | 1658 | 08:07:37 INFO - PROCESS | 1658 | [#3] mootools.html Cycles:180 Average:5693.22 Median:4956.60 stddev:3197.66 (64.5%) stddev-sans-first:3190.01 08:07:37 INFO - PROCESS | 1658 | Values: 1355.2 1491.9 1598.5 1839.5 1884.3 8464.2 8930.8 8931.3 8960.5 8978.1 7774.9 8082.8 8098.8 8470.4 8720.3 2381.5 2404.6 2407.6 2410.1 2410.2 2366.0 2380.8 2418.2 2418.4 2419.7 2096.8 2181.8 2188.3 2335.5 2415.8 2389.8 2408.5 2410.5 2414.2 2418.3 2172.7 2292.5 2367.7 2403.6 2407.7 8728.6 8808.3 8878.9 8888.7 8906.1 5209.3 5312.4 5379.3 5391.8 5394.5 3447.8 3525.5 3667.1 3669.8 3674.3 1085.8 1090.9 1099.3 1106.5 1109.0 11562.1 11779.9 11781.0 11788.4 11796.5 4545.5 4658.1 4768.8 4781.4 4789.6 10091.6 10093.5 10094.5 10095.3 10107.1 5345.9 5363.2 5364.1 5366.5 5369.9 3683.7 4913.5 4922.4 4922.8 4930.6 3677.7 3702.6 3737.5 3758.6 3764.2 1145.8 1146.6 1160.6 1160.8 1167.3 623.5 764.7 904.3 904.3 954.6 5810.8 5921.7 6074.8 6124.9 6130.9 770.6 941.2 964.2 968.2 1007.2 3537.0 3886.1 3919.5 3936.6 4057.7 8648.6 10751.8 10769.6 10772.9 10801.9 10760.0 10761.2 10763.0 10772.8 10779.4 7782.3 8086.1 8110.1 8112.2 8140.0 5634.6 5913.6 5947.2 6083.7 6130.4 9651.5 9918.2 9940.4 9946.0 9992.7 9637.8 10024.2 10046.8 10047.1 10068.7 8123.6 8151.2 8318.0 8319.1 8329.0 7904.8 8199.8 8278.3 8295.1 8354.3 6831.0 6832.3 6878.0 7291.7 7428.1 6118.2 7168.7 7239.5 7303.4 7461.5 6771.3 6946.2 6955.0 6956.3 6960.5 4845.3 4984.3 5057.0 5119.1 5123.7 4548.7 4982.6 5084.1 5132.7 5275.9 08:07:37 INFO - PROCESS | 1658 | 08:07:37 INFO - PROCESS | 1658 | [#4] prototype.html Cycles:180 Average:4436.44 Median:5023.72 stddev:1376.87 (27.4%) stddev-sans-first:1345.26 08:07:37 INFO - PROCESS | 1658 | Values: 299.4 299.6 308.2 315.5 316.4 5263.6 5322.6 5353.9 5362.6 5381.8 4034.4 5039.9 5079.9 5120.6 5323.1 3561.5 3603.0 3900.3 4000.2 4081.7 3515.0 4024.7 4024.7 4051.2 4072.5 3912.8 3984.3 3992.7 4005.0 4057.1 3444.2 3968.0 4003.6 4047.7 4063.3 2919.9 3263.7 3514.2 3517.9 3528.7 5152.2 5189.1 5195.8 5197.7 5199.6 4126.9 4222.4 4267.8 4514.5 4568.2 4438.6 5086.8 5557.2 5561.9 5669.5 3200.2 3366.4 3667.9 3791.1 3816.8 5514.9 5792.7 5794.2 5832.4 5833.4 3449.8 3514.9 3700.5 3812.6 3813.8 3885.9 3897.4 3909.2 3911.2 3923.9 3504.6 3865.3 4003.4 4561.8 4697.1 4640.5 5007.5 5577.9 5602.7 5608.0 1118.4 1307.7 1318.6 1338.6 1340.3 830.8 848.8 856.3 872.3 885.9 4201.4 4671.9 4824.9 5058.9 5190.5 5043.8 5667.0 5691.6 5738.3 5766.0 4748.9 4881.4 5096.5 5121.2 5143.5 2789.9 2974.2 2979.6 2992.7 2994.8 4967.6 5534.4 5607.8 5785.5 5934.9 5000.9 5109.8 5728.0 5747.7 5795.6 5239.6 5372.7 5571.5 5808.4 5894.9 4068.8 4522.5 5251.6 5411.4 5759.7 4847.6 4983.8 5195.5 5724.7 5725.3 5343.9 5509.4 5808.9 6010.4 6072.8 3459.6 3589.2 3658.0 3796.8 3806.1 5482.7 5709.9 5746.3 5761.7 5772.9 4673.7 5591.6 5623.9 5632.2 5649.5 4771.6 4944.3 5215.3 5621.7 5666.6 4603.3 4768.3 5483.8 5505.6 5523.5 5165.6 5405.8 5565.6 5692.3 5694.3 4766.2 5130.5 5216.0 5319.5 5588.3 08:07:37 INFO - PROCESS | 1658 | 08:07:37 INFO - PROCESS | 1658 | [#5] yui.html Cycles:180 Average:25464.24 Median:12814.56 stddev:41732.56 (325.7%) stddev-sans-first:41807.94 08:07:37 INFO - PROCESS | 1658 | Values: 618.8 688.8 759.7 781.9 816.0 15434.8 16017.6 16058.2 16060.3 16102.6 14038.6 14364.4 14476.6 14477.6 14494.9 678.4 696.2 825.1 852.8 853.3 860.6 862.7 864.8 868.4 868.6 921.0 921.8 923.4 927.0 927.7 716.9 734.9 884.3 919.0 920.6 671.7 672.0 672.6 674.9 675.9 15269.2 15271.9 15289.9 15295.7 15302.5 13499.9 13701.2 13754.1 13759.2 13911.0 12185.1 12310.3 12310.8 12354.3 12852.8 4399.9 4428.0 4488.7 4566.2 4651.1 86831.0 102517.5 112789.0 114332.0 120266.2 10511.3 10525.2 10556.2 10573.8 10976.9 21807.7 21818.5 21920.0 21946.0 22203.7 6607.7 7817.0 7835.3 7874.0 7958.0 4312.2 4407.5 4415.1 4578.6 4648.5 3425.5 3560.0 3568.8 3570.6 3580.3 656.7 679.2 684.7 688.4 688.7 531.6 532.8 588.9 604.4 651.8 8658.4 8902.0 8980.6 10032.8 10234.3 602.9 636.9 642.7 650.9 695.8 4467.5 4673.5 4696.9 4727.0 4727.3 155613.2 157005.0 157333.0 161660.0 167325.0 131790.0 136715.0 138295.0 139297.3 141123.0 96935.0 118886.0 119264.0 122119.4 124437.4 8927.0 9034.5 9075.2 9091.1 9096.2 62311.7 62815.0 63114.4 63863.0 64042.4 80554.0 91859.0 99109.5 99398.0 102007.5 11248.2 11629.1 11843.4 11977.0 12123.8 12777.4 12895.7 12943.5 13067.1 13150.7 10838.9 11869.1 12197.9 12478.3 12657.2 11821.8 12075.5 12209.1 12337.3 12524.3 11484.7 11763.8 11945.4 12586.8 13031.7 10464.7 11250.7 11293.2 11705.5 11948.5 10787.5 11225.2 11423.2 11660.8 11673.1 08:07:37 INFO - PROCESS | 1658 | -------- Summary: end -------- 08:07:37 INFO - PROCESS | 1658 | 08:07:38 INFO - TEST-INFO | 1658: exit 0 08:07:38 INFO - TEST-OK | dromaeo_css | took 1117718ms 08:07:38 INFO - TEST-START | kraken 08:07:38 INFO - operating with platform_type : mac_ 08:07:38 INFO - Initialising browser for kraken test... 08:07:38 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/tmp0np5ba/profile http://localhost:49272/getInfo.html) 08:07:40 INFO - PROCESS | 1664 | __metrics Screen width/height:1600/1200 08:07:40 INFO - PROCESS | 1664 | colorDepth:24 08:07:40 INFO - PROCESS | 1664 | Browser inner width/height: 1024/689 08:07:40 INFO - PROCESS | 1664 | __metrics 08:07:40 INFO - PROCESS | 1664 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:07:40 INFO - PROCESS | 1664 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:07:41 INFO - TEST-INFO | 1664: exit 0 08:07:41 INFO - Browser initialized. 08:07:41 INFO - Running cycle 1/1 for kraken test... 08:07:41 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/tmp0np5ba/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:07:53 INFO - PROCESS | 1665 | RSS: Main: 235597824 08:07:53 INFO - PROCESS | 1665 | 08:07:56 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 08:07:57 INFO - PROCESS | 1665 | RSS: Main: 294240256 08:07:57 INFO - PROCESS | 1665 | 08:07:59 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 08:08:00 INFO - PROCESS | 1665 | RSS: Main: 294170624 08:08:00 INFO - PROCESS | 1665 | 08:08:03 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 08:08:04 INFO - PROCESS | 1665 | RSS: Main: 385515520 08:08:04 INFO - PROCESS | 1665 | 08:08:06 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 08:08:07 INFO - PROCESS | 1665 | RSS: Main: 287105024 08:08:07 INFO - PROCESS | 1665 | 08:08:09 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:08:09 INFO - PROCESS | 1665 | RSS: Main: 291311616 08:08:09 INFO - PROCESS | 1665 | 08:08:12 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 08:08:13 INFO - PROCESS | 1665 | RSS: Main: 328843264 08:08:13 INFO - PROCESS | 1665 | 08:08:16 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 08:08:16 INFO - PROCESS | 1665 | RSS: Main: 330174464 08:08:16 INFO - PROCESS | 1665 | 08:08:19 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 08:08:20 INFO - PROCESS | 1665 | RSS: Main: 329367552 08:08:20 INFO - PROCESS | 1665 | 08:08:21 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:08:22 INFO - PROCESS | 1665 | RSS: Main: 300507136 08:08:22 INFO - PROCESS | 1665 | 08:08:24 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:08:24 INFO - PROCESS | 1665 | RSS: Main: 304353280 08:08:24 INFO - PROCESS | 1665 | 08:08:27 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:08:27 INFO - PROCESS | 1665 | RSS: Main: 307023872 08:08:27 INFO - PROCESS | 1665 | 08:08:30 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:08:31 INFO - PROCESS | 1665 | RSS: Main: 316485632 08:08:31 INFO - PROCESS | 1665 | 08:08:34 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:08:35 INFO - PROCESS | 1665 | RSS: Main: 318427136 08:08:35 INFO - PROCESS | 1665 | 08:08:37 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 08:08:37 INFO - PROCESS | 1665 | RSS: Main: 361877504 08:08:37 INFO - PROCESS | 1665 | 08:08:37 INFO - PROCESS | 1665 | __start_tp_report 08:08:37 INFO - PROCESS | 1665 | _x_x_mozilla_page_load 08:08:37 INFO - PROCESS | 1665 | _x_x_mozilla_page_load_details 08:08:37 INFO - PROCESS | 1665 | |i|pagename|runs| 08:08:37 INFO - PROCESS | 1665 | |0;ai-astar;113;114;161;165;112;112;110;112;111;111 08:08:37 INFO - PROCESS | 1665 | |1;audio-beat-detection;146;111;111;144;109;98;128;116;123;129 08:08:37 INFO - PROCESS | 1665 | |2;audio-dft;183;186;186;185;188;182;184;184;186;181 08:08:37 INFO - PROCESS | 1665 | |3;audio-fft;79;60;60;89;62;59;60;59;92;58 08:08:37 INFO - PROCESS | 1665 | |4;audio-oscillator;89;71;93;68;67;69;93;92;98;123 08:08:37 INFO - PROCESS | 1665 | |5;imaging-gaussian-blur;87;85;88;86;86;84;89;85;87;85 08:08:37 INFO - PROCESS | 1665 | |6;imaging-darkroom;95;96;95;95;95;96;96;95;96;96 08:08:37 INFO - PROCESS | 1665 | |7;imaging-desaturate;85;85;86;84;85;85;85;85;84;99 08:08:37 INFO - PROCESS | 1665 | |8;json-parse-financial;57;53;53;55;54;57;55;54;54;55 08:08:37 INFO - PROCESS | 1665 | |9;json-stringify-tinderbox;68;73;68;75;73;70;70;74;72;71 08:08:37 INFO - PROCESS | 1665 | |10;stanford-crypto-aes;89;87;98;103;105;85;88;84;86;87 08:08:37 INFO - PROCESS | 1665 | |11;stanford-crypto-ccm;119;143;148;147;147;138;139;138;173;137 08:08:37 INFO - PROCESS | 1665 | |12;stanford-crypto-pbkdf2;171;174;171;169;164;228;235;218;174;168 08:08:37 INFO - PROCESS | 1665 | |13;stanford-crypto-sha256-iterative;69;68;69;79;85;84;84;85;85;67 08:08:37 INFO - PROCESS | 1665 | __end_tp_report 08:08:37 INFO - PROCESS | 1665 | __start_cc_report 08:08:37 INFO - PROCESS | 1665 | _x_x_mozilla_cycle_collect,2004 08:08:37 INFO - PROCESS | 1665 | __end_cc_report 08:08:37 INFO - PROCESS | 1665 | __startTimestamp1474643317412__endTimestamp 08:08:37 INFO - PROCESS | 1665 | 08:08:37 INFO - PROCESS | 1665 | ------- Summary: start ------- 08:08:37 INFO - PROCESS | 1665 | Number of tests: 14 08:08:37 INFO - PROCESS | 1665 | 08:08:37 INFO - PROCESS | 1665 | [#0] ai-astar Cycles:10 Average:122.10 Median:112.50 stddev:21.60 (19.2%) stddev-sans-first:22.66 08:08:37 INFO - PROCESS | 1665 | Values: 113.0 114.0 161.0 165.0 112.0 112.0 110.0 112.0 111.0 111.0 08:08:37 INFO - PROCESS | 1665 | 08:08:37 INFO - PROCESS | 1665 | [#1] audio-beat-detection Cycles:10 Average:121.50 Median:128.50 stddev:15.52 (12.1%) stddev-sans-first:13.69 08:08:37 INFO - PROCESS | 1665 | Values: 146.0 111.0 111.0 144.0 109.0 98.0 128.0 116.0 123.0 129.0 08:08:37 INFO - PROCESS | 1665 | 08:08:37 INFO - PROCESS | 1665 | [#2] audio-dft Cycles:10 Average:184.50 Median:185.50 stddev:2.12 (1.1%) stddev-sans-first:2.18 08:08:37 INFO - PROCESS | 1665 | Values: 183.0 186.0 186.0 185.0 188.0 182.0 184.0 184.0 186.0 181.0 08:08:37 INFO - PROCESS | 1665 | 08:08:37 INFO - PROCESS | 1665 | [#3] audio-fft Cycles:10 Average:67.80 Median:61.00 stddev:13.45 (22.0%) stddev-sans-first:13.64 08:08:37 INFO - PROCESS | 1665 | Values: 79.0 60.0 60.0 89.0 62.0 59.0 60.0 59.0 92.0 58.0 08:08:37 INFO - PROCESS | 1665 | 08:08:37 INFO - PROCESS | 1665 | [#4] audio-oscillator Cycles:10 Average:86.30 Median:90.50 stddev:17.81 (19.7%) stddev-sans-first:18.86 08:08:37 INFO - PROCESS | 1665 | Values: 89.0 71.0 93.0 68.0 67.0 69.0 93.0 92.0 98.0 123.0 08:08:37 INFO - PROCESS | 1665 | 08:08:37 INFO - PROCESS | 1665 | [#5] imaging-gaussian-blur Cycles:10 Average:86.20 Median:86.50 stddev:1.55 (1.8%) stddev-sans-first:1.62 08:08:37 INFO - PROCESS | 1665 | Values: 87.0 85.0 88.0 86.0 86.0 84.0 89.0 85.0 87.0 85.0 08:08:37 INFO - PROCESS | 1665 | 08:08:37 INFO - PROCESS | 1665 | [#6] imaging-darkroom Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 08:08:37 INFO - PROCESS | 1665 | Values: 95.0 96.0 95.0 95.0 95.0 96.0 96.0 95.0 96.0 96.0 08:08:37 INFO - PROCESS | 1665 | 08:08:37 INFO - PROCESS | 1665 | [#7] imaging-desaturate Cycles:10 Average:86.30 Median:85.00 stddev:4.50 (5.3%) stddev-sans-first:4.75 08:08:37 INFO - PROCESS | 1665 | Values: 85.0 85.0 86.0 84.0 85.0 85.0 85.0 85.0 84.0 99.0 08:08:37 INFO - PROCESS | 1665 | 08:08:37 INFO - PROCESS | 1665 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:55.00 stddev:1.42 (2.6%) stddev-sans-first:1.24 08:08:37 INFO - PROCESS | 1665 | Values: 57.0 53.0 53.0 55.0 54.0 57.0 55.0 54.0 54.0 55.0 08:08:37 INFO - PROCESS | 1665 | 08:08:37 INFO - PROCESS | 1665 | [#9] json-stringify-tinderbox Cycles:10 Average:71.40 Median:72.50 stddev:2.41 (3.3%) stddev-sans-first:2.22 08:08:37 INFO - PROCESS | 1665 | Values: 68.0 73.0 68.0 75.0 73.0 70.0 70.0 74.0 72.0 71.0 08:08:37 INFO - PROCESS | 1665 | 08:08:37 INFO - PROCESS | 1665 | [#10] stanford-crypto-aes Cycles:10 Average:91.20 Median:87.00 stddev:7.77 (8.9%) stddev-sans-first:8.20 08:08:37 INFO - PROCESS | 1665 | Values: 89.0 87.0 98.0 103.0 105.0 85.0 88.0 84.0 86.0 87.0 08:08:37 INFO - PROCESS | 1665 | 08:08:37 INFO - PROCESS | 1665 | [#11] stanford-crypto-ccm Cycles:10 Average:142.90 Median:145.00 stddev:13.48 (9.3%) stddev-sans-first:11.18 08:08:37 INFO - PROCESS | 1665 | Values: 119.0 143.0 148.0 147.0 147.0 138.0 139.0 138.0 173.0 137.0 08:08:37 INFO - PROCESS | 1665 | 08:08:37 INFO - PROCESS | 1665 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:187.20 Median:174.00 stddev:27.91 (16.0%) stddev-sans-first:28.98 08:08:37 INFO - PROCESS | 1665 | Values: 171.0 174.0 171.0 169.0 164.0 228.0 235.0 218.0 174.0 168.0 08:08:37 INFO - PROCESS | 1665 | 08:08:37 INFO - PROCESS | 1665 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.50 Median:84.00 stddev:8.17 (9.7%) stddev-sans-first:8.06 08:08:37 INFO - PROCESS | 1665 | Values: 69.0 68.0 69.0 79.0 85.0 84.0 84.0 85.0 85.0 67.0 08:08:37 INFO - PROCESS | 1665 | -------- Summary: end -------- 08:08:37 INFO - PROCESS | 1665 | 08:08:38 INFO - TEST-INFO | 1665: exit 0 08:08:38 INFO - TEST-OK | kraken | took 60177ms 08:08:38 INFO - SUITE-END | took 1177s 08:08:38 INFO - Completed test suite (00:19:38) 08:08:38 INFO - javascript benchmark 08:08:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3270.5094235864617, 3282.606087269527, 3329.7669163158575, 3343.1976325681844, 3376.0, 5505.146702261146, 5540.833774986747, 5570.721463926808, 5596.63621864579, 5620.831375058745, 5548.4174161713045, 5590.329160500735, 5601.047821870282, 5636.718164091789, 5648.717564121788, 5116.155834287338, 5147.819826306089, 5179.637425380225, 5184.196449550326, 5184.637075404723, 4363.498197707273, 5058.721770302632, 5158.148905430599, 5211.557017653485, 5228.529432351088, 5212.374515058198, 5221.62533543765, 5231.555317797992, 5238.52853243208, 5242.423333433319, 5077.517635824591, 5102.795888164469, 5116.488351164891, 5170.612204084671, 5212.739363031871, 5111.821086261963, 5113.82101626445, 5159.993801208766, 5168.9741551292, 5221.373435187764, 5572.637778544382, 5605.831825045255, 5625.5218306444, 5638.746256418471, 5643.5767317451355, 5976.581639285252, 6161.229846269216, 6163.322034576193, 6167.506599472032, 6183.81448556544, 6101.755929762849, 6121.755129794803, 6126.8774624507705, 6133.610107582703, 6143.262808463013, 5644.802431914945, 5649.209110724501, 5660.716964151776, 5687.488126068673, 5772.076467765138, 6120.540959428061, 6276.686165691697, 6276.937230627726, 6304.495640348853, 6309.116723658692, 5857.179994800731, 5916.526677865761, 6055.031195008777, 6063.96912524863, 6070.575059745775, 6055.636661800306, 6106.847328816815, 6107.006761825686, 6114.236541168675, 6170.568060235741, 6134.631922084689, 6142.170806941095, 6144.78493252734, 6145.139680444741, 6150.985087460519, 5993.610415323077, 6175.660338681326, 6185.165002724574, 6189.473894718909, 6196.349383314777, 4811.206150985048, 4812.927806082912, 4853.247746599212, 4857.611391088704, 4858.902821943541, 4358.259095953696, 4371.0, 4381.430414046154, 4393.18726035678, 4414.315781053878, 5667.433256674382, 5692.260006199168, 5694.345150307768, 5697.202391665171, 5706.514946229534, 6052.213212282375, 6116.853194528077, 6118.862843289934, 6143.109249158847, 6171.6297022178815, 5698.886022279614, 5714.0571805652435, 5716.142578613241, 5716.885662286731, 5717.914231286451, 5328.813491527778, 5347.465253474621, 5356.250124982505, 5359.249705041298, 5362.651427657268, 6175.876482470236, 6183.196184496167, 6220.875582488235, 6283.08895210192, 6296.33888441707, 6139.2161661365335, 6195.1636529068, 6207.348228435949, 6215.223097112861, 6223.066540019034, 6225.782097626561, 6245.5628106033955, 6261.24865016201, 6276.1213430118905, 6321.462675672436, 5946.613470124428, 6007.12896629995, 6071.119687645355, 6075.058365953284, 6079.209702738615, 6108.372425856702, 6129.601575897553, 6181.196444462191, 6204.720787564661, 6233.283172435228, 6012.518998480198, 6013.278406591237, 6029.879402412015, 6059.878802423838, 6075.392460754066, 5093.592512598909, 5989.401059893976, 6004.42957918997, 6007.429294217042, 6017.699115044318, 4904.607631389552, 5324.254604355471, 5749.91375129365, 5817.738201780845, 5840.649561026352, 5974.641521508724, 5997.520198384206, 6014.729337179925, 6021.277446706424, 6035.758569657341, 5650.208970744181, 5716.657000579979, 5724.4561766632105, 5796.507296879644, 5828.184054232326], "value": 5611.694259040549, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [469.48825779899903, 498.8553319537334, 513.9537441630254, 525.5427777833286, 526.6260954722145, 27713.0, 30784.84607576962, 40152.397714034276, 41128.79435602825, 41178.0, 41271.38092928608, 43442.56557434425, 43497.78251108748, 43498.782506087424, 43572.78213608928, 8698.434601750865, 9580.377275477107, 9753.21974242059, 9762.07260310273, 9780.951095244514, 8741.169588889044, 11836.881631183707, 12079.818802717966, 12090.214136081171, 12140.0, 11563.421828908564, 11844.7631047379, 11924.403779811018, 11960.102992275572, 11993.64019079429, 11748.941255293712, 11820.88179118215, 11829.822552661717, 11836.822447663291, 11864.406779661025, 11534.307941523452, 11736.647900562997, 11762.882371176263, 11775.470103845348, 11783.116266279978, 39870.601293986976, 40207.0, 40219.0, 40247.99380015494, 40255.59744402577, 3329.667033296675, 3373.308471763283, 3439.4496880499, 3459.584849818038, 3915.353966595508, 29609.0, 30980.38039239225, 30985.76056957719, 31013.689863101306, 31141.688583114104, 3226.4998925166637, 3259.26666500038, 3349.7271037006026, 3379.2734562069027, 3379.8141102239365, 359041.0, 363606.0, 363842.0, 363998.0, 365593.1720341408, 61487.692561536904, 61826.0, 62043.759124817254, 62122.689386552775, 62143.13570592889, 64835.0, 65268.0, 65372.67313663401, 65455.01817472742, 65529.0, 16092.275847586887, 16291.941023833413, 16324.918375408048, 16342.264598093114, 16349.34602615882, 11382.54469821198, 11602.245854019462, 11614.477348519336, 12563.371831408393, 12635.93682031584, 17340.826591734174, 17372.0, 17492.82507174912, 17559.912200438917, 17641.117944102745, 5937.324931707853, 6017.194841547605, 6026.638401695912, 6033.7586496540525, 6051.092336149525, 710.3180946291618, 819.5779173725537, 871.7820544863785, 945.9877930614176, 953.6233187890745, 29098.7090129096, 29135.417291654474, 29178.562321565194, 29866.850665746533, 29992.55011174834, 1035.694470131313, 1063.0538820449806, 1066.6373433032807, 1081.4754843900703, 1168.684455197109, 15100.54698359051, 15643.608909777347, 15653.921730391503, 15720.0, 16045.759313610306, 187825.18262226076, 189169.0, 189479.0, 189725.05137474224, 190334.04832975747, 58515.0, 58741.82516349734, 58861.0, 58915.821683566086, 58994.0, 1188.4889497515978, 1216.403962058585, 1305.3408028945512, 1320.6962398648366, 1342.8657134286493, 23523.0, 29628.407431851672, 29822.701772981993, 31088.22279443032, 31181.8440907794, 50009.0, 50373.97756134644, 50591.241131383795, 50607.240891387395, 50751.0, 427672.0, 429280.0, 431268.0, 432458.0, 432614.0, 25772.226833195033, 25774.0, 26120.477590448463, 26388.868055659597, 26785.0, 46707.53292467032, 47083.29375059308, 47534.762326188145, 47849.0, 48067.038659225924, 38368.2326353477, 38550.22899541938, 38554.421683675326, 39593.01017474586, 40262.39606405848, 38305.0, 38691.613083868804, 39320.41019384655, 39934.0, 40169.59830401659, 37726.245475089796, 38453.80773096228, 38515.807420963836, 38733.80633096817, 38829.61170388373, 28190.0, 30824.0, 34115.488267676505, 34189.14462178019, 34300.31399372048, 25196.0, 25215.49569008573, 25526.23421297364, 25608.35979100463, 25627.846746896063], "value": 19139.240477289455, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.72776048717856, 349.6468566747584, 368.42893515051645, 370.6904734546653, 405.07036351573134, 15292.694146117072, 15549.74186553134, 18184.45446636603, 19694.113764880578, 19848.503787405323, 19487.805121948775, 19498.70751938722, 19549.804501954975, 19607.725497842664, 19622.0, 5575.215930902113, 5777.537796976253, 5851.385604511529, 5904.616199947011, 5908.556858235628, 3563.6080031196548, 5524.922640085165, 5794.333651630074, 5892.734826932777, 5910.527157827385, 4260.31834906415, 4304.24675681756, 6481.254655714582, 6562.179727534059, 6573.638449885254, 6250.1874756281395, 6457.515686323498, 6569.441597464197, 6573.737050517973, 6577.506686998447, 5393.541548968343, 5580.832575022756, 5596.6362186458155, 5605.411431799643, 5622.887542249132, 20686.482837929023, 21338.466538336666, 23800.166994155123, 24736.876315618305, 25036.0, 2022.1203776357331, 2177.2706143441965, 2229.788170123852, 2298.0348253733473, 3009.292816188194, 8507.404481686284, 9982.900170998342, 10184.94907525465, 13366.930645548333, 13754.31228438584, 1710.529604358799, 1811.194018661696, 1835.9173837177225, 1859.2098358197848, 1914.9808501915081, 122755.3862230692, 124087.0, 126301.0, 126520.0, 128554.07168892381, 10773.676789696321, 11065.0, 11116.110711143088, 11125.82384362082, 11258.43707814606, 12195.268283902995, 12658.873411265953, 12685.429155688016, 12936.800743873564, 12964.80552791709, 7602.657880395395, 7606.315431611071, 7667.271609197117, 8063.072746634095, 8177.182281771894, 7688.615569221516, 7986.361091112697, 8085.595720213966, 8246.463979841292, 8264.917350826536, 4341.283688191476, 4344.304911214191, 4402.823887044547, 4421.204183246982, 4438.533953934855, 1729.1181497436398, 1764.514758441439, 1810.9275628974694, 1820.4720631016858, 1825.415866922572, 899.1862364560084, 907.2016625369764, 916.4180745226829, 942.5004747483845, 975.9463229522303, 19642.312519061765, 20223.08996095179, 20234.494137646678, 20284.695729564068, 20448.514594680906, 920.2545937790411, 972.6838777397375, 992.0, 1011.2112552209288, 1013.0983424751977, 10168.339057961357, 10558.366498010144, 10615.363078215332, 10677.199210059276, 10700.892991070144, 428865.0, 436215.0, 436401.0, 580865.0, 586867.0, 143338.0, 148348.0, 151357.0, 152820.0, 154437.22781386247, 918.4122161816442, 937.8077494113691, 972.6109556177586, 981.9214462842956, 983.4836710726926, 14153.603529417767, 16585.253663584925, 18484.260629574666, 18549.979751113817, 18849.434516964513, 43321.0, 53928.73035634954, 54518.55110426855, 54693.453065468835, 55478.44521554894, 79156.3349864019, 80677.0, 81113.0, 81544.70170694495, 82420.58789706013, 6609.636469994197, 7555.244475552401, 7975.361971042419, 8146.674133034612, 8166.142555031636, 11301.547938082385, 12480.563180288646, 12517.687057823627, 12799.872001279868, 12925.482980680668, 10930.180236482136, 11085.667429977113, 11121.666350009513, 11143.108551315712, 11302.982731554199, 8398.412111152405, 8973.37186396972, 10819.404932728776, 11104.722381940515, 11133.05369043608, 11127.221094523306, 11143.498542565441, 11189.664310070712, 11257.71855703614, 11448.542058317575, 6714.697838597177, 8011.479253848481, 8022.719204827803, 8035.236652518001, 8262.049864265686, 10008.84986725185, 10637.840432393365, 10786.784264314827, 10848.783024339627, 10913.618023369145], "value": 9314.208083926182, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1355.2139758939813, 1491.880649548036, 1598.4804938395025, 1839.5125291797667, 1884.3404808317082, 8464.153584641534, 8930.776730581738, 8931.330150238726, 8960.507172105532, 8978.147076027775, 7774.92225077749, 8082.838343233132, 8098.757037288876, 8470.364722645796, 8720.302375809935, 2381.4760752634393, 2404.627282771173, 2407.590709579367, 2410.13235235316, 2410.216679579135, 2366.0, 2380.833341666084, 2418.2382549496942, 2418.4316685578965, 2419.7338292787867, 2096.7693553709078, 2181.7818218178213, 2188.3106821351303, 2335.4511689752894, 2415.7825795678386, 2389.8446600970883, 2408.458096928177, 2410.4817464245184, 2414.1550457339968, 2418.2745176446997, 2172.728953562168, 2292.484191056999, 2367.7040369953756, 2403.6034054381007, 2407.6990376202975, 8728.563571821447, 8808.28238493494, 8878.86681699775, 8888.73333799987, 8906.109389061106, 5209.348831396075, 5312.442193569658, 5379.300690910196, 5391.81128660495, 5394.541463975567, 3447.7586568940183, 3525.541679581638, 3667.064898450878, 3669.7798132112157, 3674.3018826422895, 1085.7925538538166, 1090.8745494268182, 1099.2580008494315, 1106.5463160104398, 1109.046220250584, 11562.132840036948, 11779.882201177965, 11780.998615117725, 11788.351640659761, 11796.52813887452, 4545.522720114341, 4658.138244424792, 4768.809247630125, 4781.402324709411, 4789.640776941744, 10091.646792362379, 10093.495325233709, 10094.49527523621, 10095.293329466867, 10107.09036186732, 5345.919811202835, 5363.19552067193, 5364.114921037985, 5366.463353664602, 5369.919451208235, 3683.7053035757076, 4913.533214344631, 4922.384701912261, 4922.827701030446, 4930.580900623416, 3677.7425580209665, 3702.648248416396, 3737.4954381158195, 3758.6053464385845, 3764.228333191689, 1145.7823013627385, 1146.6158836789602, 1160.5879912631062, 1160.8490896183441, 1167.3404526442532, 623.4856243599049, 764.694122351064, 904.3127223310331, 904.3262769236829, 954.5704433005176, 5810.82567522975, 5921.73352199152, 6074.787382441682, 6124.938750612526, 6130.915488733763, 770.5569297653872, 941.1576638908139, 964.2382517810851, 968.1722127580957, 1007.1640538353149, 3536.982315088408, 3886.095813051584, 3919.510061242345, 3936.626020528045, 4057.69567282455, 8648.610812513452, 10751.83872241917, 10769.62306319275, 10772.922707729322, 10801.945990269998, 10760.031597156138, 10761.24671273019, 10763.0, 10772.838407423895, 10779.407132607625, 7782.260685234894, 8086.110527841933, 8110.107888132301, 8112.22933821286, 8139.959300203461, 5634.6337488063145, 5913.586048976703, 5947.197128387786, 6083.726232319467, 6130.356312587114, 9651.517424128906, 9918.20654347636, 9940.403575785476, 9945.950270248602, 9992.65025724096, 9637.759056023655, 10024.24818138657, 10046.849297260693, 10047.09576138151, 10068.697939061547, 8123.5532045738055, 8151.225633564802, 8317.95841020791, 8319.126491718525, 8329.0, 7904.84190316202, 8199.795005124919, 8278.296344810758, 8295.129011453952, 8354.289885359813, 6831.043653888559, 6832.282610326043, 6878.0, 7291.671874765542, 7428.071491063617, 6118.235220597426, 7168.67740951648, 7239.529430586995, 7303.379212766762, 7461.515001524884, 6771.255161932282, 6946.16646002483, 6954.9915262287695, 6956.339147780953, 6960.547564408297, 4845.289025967538, 4984.277279794482, 5056.963322518948, 5119.129747942784, 5123.743812809419, 4548.727076375428, 4982.626303027215, 5084.135696931457, 5132.743362831919, 5275.868103297448], "value": 4562.510315835331, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.38327046284667, 299.6209794609818, 308.1541169489751, 315.5109580150766, 316.43516323362803, 5263.631545791796, 5322.6008049396305, 5353.89292214156, 5362.597805164609, 5381.81163659272, 4034.354503279476, 5039.899202015958, 5079.898402031957, 5120.569218623522, 5323.148296272597, 3561.5013898054294, 3602.9819850900776, 3900.278448487025, 4000.1999600079953, 4081.693872959525, 3514.9648503514895, 4024.7182697211206, 4024.7182697211206, 4051.210014047262, 4072.511298644167, 3912.784796836173, 3984.3027470192746, 3992.6606238469767, 4005.0, 4057.127717540728, 3444.207832198583, 3967.988163018441, 4003.5996400360023, 4047.7368971017086, 4063.349864021757, 2919.9124026279246, 3263.7225835803984, 3514.1741690702665, 3517.8768743094124, 3528.7177025837873, 5152.227165925104, 5189.117849965515, 5195.818146364897, 5197.714125723083, 5199.6360254782185, 4126.855560055384, 4222.408862759216, 4267.765272909989, 4514.525974772634, 4568.2462393705, 4438.622717069053, 5086.847394578169, 5557.166425036236, 5561.916571251434, 5669.461401166883, 3200.2159470929537, 3366.4277072897667, 3667.899630110956, 3791.0901383667997, 3816.7709937403843, 5514.862128446781, 5792.652440853562, 5794.188813566104, 5832.387599302097, 5833.445822646841, 3449.844756985942, 3514.9420004595654, 3700.5374328208973, 3812.6187381262207, 3813.771173729585, 3885.922281554353, 3897.4348719435525, 3909.179072394772, 3911.159100793343, 3923.9215215695526, 3504.56192975878, 3865.342891708416, 4003.3594624859884, 4561.794719237642, 4697.121151539343, 4640.466346370143, 5007.549320561167, 5577.888442231214, 5602.663840169603, 5608.037186984604, 1118.4463690473106, 1307.7123032932739, 1318.6241921052454, 1338.631876234024, 1340.2829486224823, 830.8213734047088, 848.8429640516524, 856.2850020233051, 872.3457406944791, 885.9014821621272, 4201.411802347674, 4671.929921051187, 4824.927626085611, 5058.861756104847, 5190.532852043334, 5043.823466178666, 5666.9716651416475, 5691.601587888891, 5738.340090889517, 5766.0, 4748.905021899612, 4881.438634557071, 5096.541311281928, 5121.180611102206, 5143.5113664201845, 2789.916302510928, 2974.1708849057673, 2979.61265035544, 2992.685767994329, 2994.82031078136, 4967.5529202371235, 5534.446555344433, 5607.80372686954, 5785.508231800344, 5934.8813023739285, 5000.949990500121, 5109.846704598868, 5727.971360143172, 5747.683877386784, 5795.594308398456, 5239.633225674166, 5372.650777699437, 5571.526420254324, 5808.361080281165, 5894.941050589525, 4068.8169032394208, 4522.479914809707, 5251.632385732962, 5411.350637923317, 5759.7408116634015, 4847.61219102478, 4983.775730092227, 5195.506426889439, 5724.742386592697, 5725.255716756795, 5343.946560534345, 5509.449055094458, 5808.912866306924, 6010.368911264429, 6072.787452439144, 3459.6194418613427, 3589.2462582857893, 3657.9940516358215, 3796.8291426885303, 3806.1436176859984, 5482.671039737628, 5709.858802948894, 5746.27052150242, 5761.654300741969, 5772.884542309214, 4673.719576825401, 5591.608587399006, 5623.8875222496135, 5632.225848857761, 5649.491545760901, 4771.618270538418, 4944.258361245842, 5215.29593504872, 5621.690807005491, 5666.631668941505, 4603.332516785114, 4768.305907162442, 5483.7806487740045, 5505.6421332614855, 5523.502884740393, 5165.60528657268, 5405.78376864921, 5565.578973146694, 5692.260006199168, 5694.316681998187, 4766.213574760264, 5130.51260130287, 5215.956808638211, 5319.494648008433, 5588.273524441796], "value": 4001.715524163427, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [618.7988903606328, 688.7781609821029, 759.7454852624367, 781.9482795639863, 815.9845182399473, 15434.845651543495, 16017.599560011005, 16058.197090145475, 16060.277287522074, 16102.597435064115, 14038.649033774136, 14364.425422983095, 14476.5657030289, 14477.5656730298, 14494.927525362358, 678.4368973751799, 696.1715558485412, 825.1253671108644, 852.791066188783, 853.3045567862173, 860.565414465694, 862.7411776467035, 864.8227113441761, 868.3834477520968, 868.6091258933506, 921.0, 921.7741653294919, 923.4090182283311, 926.9710621210451, 927.679950417105, 716.8924661300795, 734.8860926556392, 884.3058199313572, 918.9862152067724, 920.6087412849579, 671.711164199394, 671.9865602687968, 672.5930811858804, 674.8650269945981, 675.8884784010633, 15269.236538173047, 15271.923640381838, 15289.923550382287, 15295.694086118216, 15302.540923772305, 13499.932500337534, 13701.177929324273, 13754.105983111165, 13759.17444953306, 13911.010737350856, 12185.147039707224, 12310.26138431697, 12310.75378492425, 12354.320512371816, 12852.807207891889, 4399.944013436752, 4427.9557204427865, 4488.685791994561, 4566.246569316058, 4651.116287905287, 86831.0, 102517.4874125632, 112789.0, 114332.0, 120266.19600705996, 10511.26421150512, 10525.157987360994, 10556.208284378703, 10573.788524229472, 10976.945115274531, 21807.67288490642, 21818.454538636663, 21920.0, 21946.0, 22203.66694499584, 6607.669616519155, 7816.960915195387, 7835.255650713173, 7874.0, 7957.960210198912, 4312.202242585132, 4407.515173330931, 4415.072834704748, 4578.587927086578, 4648.488666246778, 3425.4519276915576, 3559.9644003559633, 3568.7680300780366, 3570.6072332043454, 3580.3018411410044, 656.6552559905992, 679.2053297641771, 684.7397988764337, 688.3942130924754, 688.6591137387026, 531.6491115863512, 532.8454748123, 588.9204957330705, 604.3925854516183, 651.7686221391433, 8658.39391242607, 8902.0, 8980.55097245135, 10032.799344013225, 10234.283600147919, 602.8553147244718, 636.8662580858072, 642.6626021338834, 650.9088727578143, 695.819087037374, 4467.508574056851, 4673.485916549177, 4696.8590942271785, 4727.0, 4727.338172655831, 155613.2219338896, 157005.0, 157333.0, 161660.0, 167325.0, 131790.0, 136715.0, 138295.0, 139297.30351348178, 141123.0, 96935.0, 118886.0, 119264.0, 122119.38940305597, 124437.37781311036, 8926.955365223132, 9034.45793252407, 9075.183233509017, 9091.090890910857, 9096.1813436791, 62311.688441557504, 62815.0, 63114.42626884803, 63863.0, 64042.359576403636, 80554.0, 91859.0, 99109.50445247728, 99398.0, 102007.4899625497, 11248.212625116163, 11629.127815413709, 11843.407829608657, 11977.001767180367, 12123.757524849278, 12777.361131943551, 12895.655373355281, 12943.5469758558, 13067.085304028627, 13150.671233219246, 10838.945805270923, 11869.109816763605, 12197.902188803051, 12478.251304921734, 12657.177283476545, 11821.82267266009, 12075.456604452997, 12209.084318676312, 12337.259764414164, 12524.311162886128, 11484.712882178012, 11763.823542646696, 11945.4027298633, 12586.811197831857, 13031.67692238511, 10464.686059417925, 11250.718732031764, 11293.208117550663, 11705.488353494087, 11948.462319195483, 10787.460626968777, 11225.15811314171, 11423.200375973935, 11660.766784664429, 11673.12451566153], "value": 7769.856218414505, "unit": "score"}], "name": "dromaeo_css", "value": 7222.35559873557, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 161.0, 165.0, 112.0, 112.0, 110.0, 112.0, 111.0, 111.0], "value": 122.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 111.0, 111.0, 144.0, 109.0, 98.0, 128.0, 116.0, 123.0, 129.0], "value": 121.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 186.0, 186.0, 185.0, 188.0, 182.0, 184.0, 184.0, 186.0, 181.0], "value": 184.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 60.0, 60.0, 89.0, 62.0, 59.0, 60.0, 59.0, 92.0, 58.0], "value": 67.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 71.0, 93.0, 68.0, 67.0, 69.0, 93.0, 92.0, 98.0, 123.0], "value": 86.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 88.0, 86.0, 86.0, 84.0, 89.0, 85.0, 87.0, 85.0], "value": 86.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0], "value": 95.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 86.0, 84.0, 85.0, 85.0, 85.0, 85.0, 84.0, 99.0], "value": 86.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 53.0, 53.0, 55.0, 54.0, 57.0, 55.0, 54.0, 54.0, 55.0], "value": 54.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 73.0, 68.0, 75.0, 73.0, 70.0, 70.0, 74.0, 72.0, 71.0], "value": 71.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 98.0, 103.0, 105.0, 85.0, 88.0, 84.0, 86.0, 87.0], "value": 91.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 143.0, 148.0, 147.0, 147.0, 138.0, 139.0, 138.0, 173.0, 137.0], "value": 142.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 174.0, 171.0, 169.0, 164.0, 228.0, 235.0, 218.0, 174.0, 168.0], "value": 187.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 69.0, 79.0, 85.0, 84.0, 84.0, 85.0, 85.0, 67.0], "value": 77.5, "unit": "score"}], "name": "kraken", "value": 1475.1000000000001, "alertThreshold": 2.0}]} 08:08:38 INFO - Return code: 0 08:08:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:08:38 INFO - # TBPL SUCCESS # 08:08:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:08:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:08:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:08:38 INFO - 2016-09-23 08:08:38.745 screenresolution[1669:10966] starting screenresolution argv=screenresolution get 08:08:38 INFO - 2016-09-23 08:08:38.748 screenresolution[1669:10966] Display 0: 1600x1200x32@60 08:08:38 INFO - 2016-09-23 08:08:38.754 screenresolution[1670:10969] starting screenresolution argv=screenresolution list 08:08:38 INFO - Available Modes on Display 0 08:08:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:08:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:08:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:08:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:08:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:08:38 INFO - Intel Iris: 08:08:38 INFO - Chipset Model: Intel Iris 08:08:38 INFO - Type: GPU 08:08:38 INFO - Bus: Built-In 08:08:38 INFO - VRAM (Dynamic, Max): 1536 MB 08:08:38 INFO - Vendor: Intel (0x8086) 08:08:38 INFO - Device ID: 0x0a2e 08:08:38 INFO - Revision ID: 0x0009 08:08:38 INFO - Displays: 08:08:38 INFO - Display: 08:08:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:08:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:08:38 INFO - Display Serial Number: 1600x1200 60 08:08:38 INFO - Main Display: Yes 08:08:38 INFO - Mirror: Off 08:08:38 INFO - Online: Yes 08:08:38 INFO - Rotation: Supported 08:08:38 INFO - Return code: 0 08:08:38 INFO - Running post-action listener: _resource_record_post_action 08:08:38 INFO - [mozharness: 2016-09-23 15:08:38.990513Z] Finished run-tests step (success) 08:08:38 INFO - Running post-run listener: _resource_record_post_run 08:08:39 INFO - Total resource usage - Wall time: 1213s; CPU: 53.0%; Read bytes: 31513600; Write bytes: 708456448; Read time: 306; Write time: 2126 08:08:39 INFO - TinderboxPrint: CPU usage
53.4% 08:08:39 INFO - TinderboxPrint: I/O read bytes / time
31,513,600 / 306 08:08:39 INFO - TinderboxPrint: I/O write bytes / time
708,456,448 / 2,126 08:08:39 INFO - TinderboxPrint: CPU idle
2,259.9 (46.6%) 08:08:39 INFO - TinderboxPrint: CPU system
969.2 (20.0%) 08:08:39 INFO - TinderboxPrint: CPU user
1,624.6 (33.5%) 08:08:39 INFO - TinderboxPrint: Swap in / out
434,421,760 / 0 08:08:39 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 390846976; Write bytes: 384681984; Read time: 29362; Write time: 716 08:08:39 INFO - run-tests - Wall time: 1179s; CPU: 53.0%; Read bytes: 30583808; Write bytes: 299530240; Read time: 293; Write time: 1309 08:08:39 INFO - Running post-run listener: _upload_blobber_files 08:08:39 INFO - Blob upload gear active. 08:08:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:08:39 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 08:08:39 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:08:39 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:08:39 INFO - (blobuploader) - INFO - Open directory for files ... 08:08:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:08:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:08:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:08:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:08:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:08:41 INFO - (blobuploader) - INFO - Done attempting. 08:08:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:08:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:08:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:08:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:08:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:08:41 INFO - (blobuploader) - INFO - Done attempting. 08:08:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:08:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:08:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:08:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:08:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:08:44 INFO - (blobuploader) - INFO - Done attempting. 08:08:44 INFO - (blobuploader) - INFO - Iteration through files over. 08:08:44 INFO - Return code: 0 08:08:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:08:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:08:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c9ffb7753fc71f796ab84347bfd325f930ce591e2307b84306f8def89e0baa7b6b25cf8333aa3b00b4a294f833ebdd43b3c24f629ab66bf488c34cd946573a39", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/3058a82e65f4dcb6fc511557f5f76ad8f3b2facea8eb92002ab07222c43b73c69b3c6543a71d6e8735d097e3a1bbdc80fd22b585a5bd139630f5adfca51f4f78", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/31a08430312e8efb7f80d6e11c391891df71bf38135ef86cf98d196fa4158f25812661d0c8e5fbb819588a23eb24662364f44c9f4f1e9fb4af728082ec5acabd"} 08:08:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:08:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:08:44 INFO - Contents: 08:08:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c9ffb7753fc71f796ab84347bfd325f930ce591e2307b84306f8def89e0baa7b6b25cf8333aa3b00b4a294f833ebdd43b3c24f629ab66bf488c34cd946573a39", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/3058a82e65f4dcb6fc511557f5f76ad8f3b2facea8eb92002ab07222c43b73c69b3c6543a71d6e8735d097e3a1bbdc80fd22b585a5bd139630f5adfca51f4f78", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/31a08430312e8efb7f80d6e11c391891df71bf38135ef86cf98d196fa4158f25812661d0c8e5fbb819588a23eb24662364f44c9f4f1e9fb4af728082ec5acabd"} 08:08:44 INFO - Running post-run listener: copy_logs_to_upload_dir 08:08:44 INFO - Copying logs to upload dir... 08:08:44 INFO - mkdir: /builds/slave/test/build/upload/logs 08:08:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1354.526981 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 34 secs) (at 2016-09-23 08:08:44.864118) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-23 08:08:44.868880) ========= 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.pHfGeLPyoY/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.8XBfIcQGsH/Listeners TMPDIR=/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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/Autoland/sha512/c9ffb7753fc71f796ab84347bfd325f930ce591e2307b84306f8def89e0baa7b6b25cf8333aa3b00b4a294f833ebdd43b3c24f629ab66bf488c34cd946573a39", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/3058a82e65f4dcb6fc511557f5f76ad8f3b2facea8eb92002ab07222c43b73c69b3c6543a71d6e8735d097e3a1bbdc80fd22b585a5bd139630f5adfca51f4f78", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/31a08430312e8efb7f80d6e11c391891df71bf38135ef86cf98d196fa4158f25812661d0c8e5fbb819588a23eb24662364f44c9f4f1e9fb4af728082ec5acabd"} build_url:https://queue.taskcluster.net/v1/task/O0qTAEdFQDCpgJqGmIJgow/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011169 build_url: 'https://queue.taskcluster.net/v1/task/O0qTAEdFQDCpgJqGmIJgow/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c9ffb7753fc71f796ab84347bfd325f930ce591e2307b84306f8def89e0baa7b6b25cf8333aa3b00b4a294f833ebdd43b3c24f629ab66bf488c34cd946573a39", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/3058a82e65f4dcb6fc511557f5f76ad8f3b2facea8eb92002ab07222c43b73c69b3c6543a71d6e8735d097e3a1bbdc80fd22b585a5bd139630f5adfca51f4f78", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/31a08430312e8efb7f80d6e11c391891df71bf38135ef86cf98d196fa4158f25812661d0c8e5fbb819588a23eb24662364f44c9f4f1e9fb4af728082ec5acabd"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-23 08:08:44.905414) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 08:08:44.905719) ========= 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.pHfGeLPyoY/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.8XBfIcQGsH/Listeners TMPDIR=/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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.005157 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 08:08:44.954230) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-23 08:08:44.957595) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-23 08:08:44.957973) ========= ========= Total master_lag: 0.18 =========