builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0369 starttime: 1475623666.39 results: success (0) buildid: 20161004141800 builduid: f61eb53279fb4e5ea39e289ca98da3a7 revision: 43c3d294f63cd8e49fca491a686f729cfd66a365 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 16:27:46.389342) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 16:27:46.389900) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 16:27:46.390244) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 16:27:46.413941) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 16:27:46.414634) ========= 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.2mHKXON1RT/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.6wKJUywe9t/Listeners TMPDIR=/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-04 16:27:46-- 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% 7.83M=0.001s 2016-10-04 16:27:46 (7.83 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.129607 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 16:27:46.569575) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 16:27:46.570216) ========= 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.2mHKXON1RT/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.6wKJUywe9t/Listeners TMPDIR=/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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.019485 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 16:27:46.622423) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-04 16:27:46.622964) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 43c3d294f63cd8e49fca491a686f729cfd66a365 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 43c3d294f63cd8e49fca491a686f729cfd66a365 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2mHKXON1RT/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.6wKJUywe9t/Listeners TMPDIR=/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-04 16:27:46,692 truncating revision to first 12 chars 2016-10-04 16:27:46,692 Setting DEBUG logging. 2016-10-04 16:27:46,692 attempt 1/10 2016-10-04 16:27:46,692 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/43c3d294f63c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-04 16:27:47,556 unpacking tar archive at: mozilla-aurora-43c3d294f63c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.123621 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-04 16:27:47.774221) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 16:27:47.774902) ========= script_repo_revision: 43c3d294f63cd8e49fca491a686f729cfd66a365 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 16:27:47.775777) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 16:27:47.776472) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 16:27:47.797296) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-10-04 16:27:47.797657) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2mHKXON1RT/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.6wKJUywe9t/Listeners TMPDIR=/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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 16:27:47 INFO - MultiFileLogger online at 20161004 16:27:47 in /builds/slave/test 16:27:47 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 16:27:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:27:47 INFO - {'append_to_log': False, 16:27:47 INFO - 'base_work_dir': '/builds/slave/test', 16:27:47 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 16:27:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:27:47 INFO - 'branch': 'Mozilla-Aurora', 16:27:47 INFO - 'buildbot_json_path': 'buildprops.json', 16:27:47 INFO - 'config_files': ('talos/mac_config.py',), 16:27:47 INFO - 'default_actions': ('clobber', 16:27:47 INFO - 'read-buildbot-config', 16:27:47 INFO - 'download-and-extract', 16:27:47 INFO - 'populate-webroot', 16:27:47 INFO - 'create-virtualenv', 16:27:47 INFO - 'install', 16:27:47 INFO - 'run-tests'), 16:27:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:27:47 INFO - 'download_minidump_stackwalk': True, 16:27:47 INFO - 'download_symbols': 'ondemand', 16:27:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:27:47 INFO - 'tooltool.py': '/tools/tooltool.py', 16:27:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:27:47 INFO - '/tools/misc-python/virtualenv.py')}, 16:27:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:27:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:27:47 INFO - 'installer_path': 'installer.exe', 16:27:47 INFO - 'log_level': 'info', 16:27:47 INFO - 'log_name': 'talos', 16:27:47 INFO - 'log_to_console': True, 16:27:47 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:27:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:27:47 INFO - 'opt_config_files': (), 16:27:47 INFO - 'pip_index': False, 16:27:47 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:27:47 INFO - 'cmd': ('bash', 16:27:47 INFO - '-c', 16:27:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:27:47 INFO - 'enabled': True, 16:27:47 INFO - 'halt_on_failure': False, 16:27:47 INFO - 'name': 'check_screen_resolution'},), 16:27:47 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:27:47 INFO - 'cmd': ('bash', 16:27:47 INFO - '-c', 16:27:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:27:47 INFO - 'enabled': True, 16:27:47 INFO - 'halt_on_failure': False, 16:27:47 INFO - 'name': 'check_screen_resolution'},), 16:27:47 INFO - 'run_cmd_checks_enabled': True, 16:27:47 INFO - 'sps_profile': False, 16:27:47 INFO - 'sps_profile_interval': 0, 16:27:47 INFO - 'suite': 'dromaeojs-e10s', 16:27:47 INFO - 'system_bits': '32', 16:27:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:27:47 INFO - 'title': 't-yosemite-r7-0369', 16:27:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:27:47 INFO - 'use_talos_json': True, 16:27:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:27:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:27:47 INFO - 'work_dir': 'build'} 16:27:47 INFO - [mozharness: 2016-10-04 23:27:47.982519Z] Running clobber step. 16:27:47 INFO - Running pre-action listener: _resource_record_pre_action 16:27:47 INFO - Running main action method: clobber 16:27:47 INFO - rmtree: /builds/slave/test/build 16:27:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:27:48 INFO - Running post-action listener: _resource_record_post_action 16:27:48 INFO - [mozharness: 2016-10-04 23:27:48.210756Z] Finished clobber step (success) 16:27:48 INFO - [mozharness: 2016-10-04 23:27:48.210888Z] Running read-buildbot-config step. 16:27:48 INFO - Running pre-action listener: _resource_record_pre_action 16:27:48 INFO - Running main action method: read_buildbot_config 16:27:48 INFO - Using buildbot properties: 16:27:48 INFO - { 16:27:48 INFO - "project": "", 16:27:48 INFO - "product": "firefox", 16:27:48 INFO - "script_repo_revision": "production", 16:27:48 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 16:27:48 INFO - "repository": "", 16:27:48 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 16:27:48 INFO - "buildid": "20161004141800", 16:27:48 INFO - "pgo_build": "False", 16:27:48 INFO - "basedir": "/builds/slave/test", 16:27:48 INFO - "buildnumber": 108, 16:27:48 INFO - "slavename": "t-yosemite-r7-0369", 16:27:48 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 16:27:48 INFO - "platform": "yosemite_r7", 16:27:48 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 16:27:48 INFO - "branch": "mozilla-aurora", 16:27:48 INFO - "repo_path": "releases/mozilla-aurora", 16:27:48 INFO - "revision": "43c3d294f63cd8e49fca491a686f729cfd66a365", 16:27:48 INFO - "stage_platform": "macosx64", 16:27:48 INFO - "builduid": "f61eb53279fb4e5ea39e289ca98da3a7", 16:27:48 INFO - "slavebuilddir": "test" 16:27:48 INFO - } 16:27:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/NatTCfiTR2C6PcYNvCwB4Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 16:27:48 INFO - Running post-action listener: _resource_record_post_action 16:27:48 INFO - [mozharness: 2016-10-04 23:27:48.214211Z] Finished read-buildbot-config step (success) 16:27:48 INFO - [mozharness: 2016-10-04 23:27:48.214316Z] Running download-and-extract step. 16:27:48 INFO - Running pre-action listener: _resource_record_pre_action 16:27:48 INFO - Running main action method: download_and_extract 16:27:48 INFO - mkdir: /builds/slave/test/build/tests 16:27:48 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')]} 16:27:48 INFO - trying https://queue.taskcluster.net/v1/task/NatTCfiTR2C6PcYNvCwB4Q/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 16:27:48 INFO - Downloading https://queue.taskcluster.net/v1/task/NatTCfiTR2C6PcYNvCwB4Q/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 16:27:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NatTCfiTR2C6PcYNvCwB4Q/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 16:27:49 INFO - Downloaded 1199 bytes. 16:27:49 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 16:27:49 INFO - Using the following test package requirements: 16:27:49 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 16:27:49 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:27:49 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 16:27:49 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:27:49 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 16:27:49 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:27:49 INFO - u'jsshell-mac.zip'], 16:27:49 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:27:49 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 16:27:49 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 16:27:49 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:27:49 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 16:27:49 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:27:49 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 16:27:49 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:27:49 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 16:27:49 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:27:49 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 16:27:49 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 16:27:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NatTCfiTR2C6PcYNvCwB4Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 16:27:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NatTCfiTR2C6PcYNvCwB4Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 16:27:49 INFO - Fetch https://queue.taskcluster.net/v1/task/NatTCfiTR2C6PcYNvCwB4Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 16:27:49 INFO - Expected file size: 16434087 16:27:56 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 16:27:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NatTCfiTR2C6PcYNvCwB4Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 16:27:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NatTCfiTR2C6PcYNvCwB4Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 16:27:56 INFO - Fetch https://queue.taskcluster.net/v1/task/NatTCfiTR2C6PcYNvCwB4Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 16:27:57 INFO - Expected file size: 16434087 16:28:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NatTCfiTR2C6PcYNvCwB4Q/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 16:28:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NatTCfiTR2C6PcYNvCwB4Q/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 16:28:04 INFO - Fetch https://queue.taskcluster.net/v1/task/NatTCfiTR2C6PcYNvCwB4Q/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 16:28:04 INFO - Expected file size: 14414059 16:28: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')]} 16:28:05 INFO - trying https://queue.taskcluster.net/v1/task/NatTCfiTR2C6PcYNvCwB4Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 16:28:05 INFO - Downloading https://queue.taskcluster.net/v1/task/NatTCfiTR2C6PcYNvCwB4Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 16:28:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NatTCfiTR2C6PcYNvCwB4Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 16:28:08 INFO - Downloaded 115317312 bytes. 16:28:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NatTCfiTR2C6PcYNvCwB4Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 16:28:08 INFO - mkdir: /builds/slave/test/properties 16:28:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:28:08 INFO - Writing to file /builds/slave/test/properties/build_url 16:28:08 INFO - Contents: 16:28:08 INFO - build_url:https://queue.taskcluster.net/v1/task/NatTCfiTR2C6PcYNvCwB4Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 16:28:09 INFO - Running post-action listener: _resource_record_post_action 16:28:09 INFO - Running post-action listener: set_extra_try_arguments 16:28:09 INFO - [mozharness: 2016-10-04 23:28:09.399891Z] Finished download-and-extract step (success) 16:28:09 INFO - [mozharness: 2016-10-04 23:28:09.400030Z] Running populate-webroot step. 16:28:09 INFO - Running pre-action listener: _resource_record_pre_action 16:28:09 INFO - Running main action method: populate_webroot 16:28:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:28:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:28:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:28:09 INFO - '--tppagecycles', 16:28:09 INFO - '7'], 16:28:09 INFO - 'tests': ['tsvgm']}}, 16:28:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:28:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:28:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:28:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:28:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:28:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:28:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:28:09 INFO - 'talos_options': ['--disable-e10s'], 16:28:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:28:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:28:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:28:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:28:09 INFO - 'talos_options': ['--disable-e10s'], 16:28:09 INFO - 'tests': ['damp', 'tps']}, 16:28:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:28:09 INFO - 'tests': ['damp', 'tps']}, 16:28:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:28:09 INFO - 'tests': ['dromaeo_dom']}, 16:28:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:28:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:28:09 INFO - 'tests': ['basic_compositor_video']}, 16:28:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:28:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:28:09 INFO - 'tests': ['a11yr', 16:28:09 INFO - 'ts_paint', 16:28:09 INFO - 'tpaint', 16:28:09 INFO - 'sessionrestore', 16:28:09 INFO - 'sessionrestore_no_auto_restore', 16:28:09 INFO - 'tabpaint']}, 16:28:09 INFO - 'other-e10s': {'tests': ['a11yr', 16:28:09 INFO - 'ts_paint', 16:28:09 INFO - 'tpaint', 16:28:09 INFO - 'sessionrestore', 16:28:09 INFO - 'sessionrestore_no_auto_restore', 16:28:09 INFO - 'tabpaint']}, 16:28:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:28:09 INFO - 'ts_paint', 16:28:09 INFO - 'tpaint', 16:28:09 INFO - 'sessionrestore', 16:28:09 INFO - 'sessionrestore_no_auto_restore', 16:28:09 INFO - 'tabpaint']}, 16:28:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:28:09 INFO - 'ts_paint', 16:28:09 INFO - 'tpaint', 16:28:09 INFO - 'sessionrestore', 16:28:09 INFO - 'sessionrestore_no_auto_restore', 16:28:09 INFO - 'tabpaint']}, 16:28:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:28:09 INFO - 'tests': ['a11yr', 16:28:09 INFO - 'ts_paint', 16:28:09 INFO - 'tpaint', 16:28:09 INFO - 'sessionrestore', 16:28:09 INFO - 'sessionrestore_no_auto_restore', 16:28:09 INFO - 'tabpaint']}, 16:28:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:28:09 INFO - 'tests': ['a11yr', 16:28:09 INFO - 'ts_paint', 16:28:09 INFO - 'tpaint', 16:28:09 INFO - 'sessionrestore', 16:28:09 INFO - 'sessionrestore_no_auto_restore', 16:28:09 INFO - 'tabpaint']}, 16:28:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:28:09 INFO - 'tests': ['tsvgx', 16:28:09 INFO - 'tsvgr_opacity', 16:28:09 INFO - 'tart', 16:28:09 INFO - 'tscrollx', 16:28:09 INFO - 'cart']}, 16:28:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:28:09 INFO - 'tsvgr_opacity', 16:28:09 INFO - 'tart', 16:28:09 INFO - 'tscrollx', 16:28:09 INFO - 'cart']}, 16:28:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:28:09 INFO - 'talos_options': ['--disable-e10s'], 16:28:09 INFO - 'tests': ['tp5o']}, 16:28:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:28:09 INFO - 'tests': ['tp5o']}, 16:28:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:28:09 INFO - 'talos_options': ['--disable-e10s', 16:28:09 INFO - '--xperf_path', 16:28:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:28:09 INFO - 'tests': ['tp5n']}, 16:28:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:28:09 INFO - 'talos_options': ['--xperf_path', 16:28:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:28:09 INFO - 'tests': ['tp5n']}}, 16:28:09 INFO - 'talos.zip': {'path': '', 16:28:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:28:09 INFO - Running post-action listener: _resource_record_post_action 16:28:09 INFO - [mozharness: 2016-10-04 23:28:09.418879Z] Finished populate-webroot step (success) 16:28:09 INFO - [mozharness: 2016-10-04 23:28:09.418993Z] Running create-virtualenv step. 16:28:09 INFO - Running pre-action listener: _resource_record_pre_action 16:28:09 INFO - Running main action method: create_virtualenv 16:28:09 INFO - Creating virtualenv /builds/slave/test/build/venv 16:28:09 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 16:28:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:28:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:28:09 INFO - Using real prefix '/tools/python27' 16:28:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:28:10 INFO - Installing distribute.............................................................................................................................................................................................done. 16:28:13 INFO - Installing pip.................done. 16:28:13 INFO - Return code: 0 16:28:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:28:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:28:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:28:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c6fd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c673570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd599ca1cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c511d30>, '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 0x10c377db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c509b20>, '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.2mHKXON1RT/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.6wKJUywe9t/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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 16:28:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:28:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:28:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2mHKXON1RT/Render', 16:28:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:28:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:28:13 INFO - 'HOME': '/Users/cltbld', 16:28:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:28:13 INFO - 'LOGNAME': 'cltbld', 16:28:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:28:13 INFO - 'MOZ_NO_REMOTE': '1', 16:28:13 INFO - 'NO_EM_RESTART': '1', 16:28:13 INFO - 'PAGER': '/bin/cat', 16:28:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:28:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:28:13 INFO - 'PWD': '/builds/slave/test', 16:28:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:28:13 INFO - 'SHELL': '/bin/bash', 16:28:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6wKJUywe9t/Listeners', 16:28:13 INFO - 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/', 16:28:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:28:13 INFO - 'USER': 'cltbld', 16:28:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:28:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:28:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:13 INFO - 'XPC_FLAGS': '0x0', 16:28:13 INFO - 'XPC_SERVICE_NAME': '0', 16:28:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:28:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:28:13 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 16:28:13 INFO - Cleaning up... 16:28:13 INFO - Return code: 0 16:28:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:28:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:28:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:28:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c6fd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c673570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd599ca1cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c511d30>, '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 0x10c377db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c509b20>, '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.2mHKXON1RT/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.6wKJUywe9t/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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 16:28:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:28:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:28:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2mHKXON1RT/Render', 16:28:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:28:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:28:13 INFO - 'HOME': '/Users/cltbld', 16:28:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:28:13 INFO - 'LOGNAME': 'cltbld', 16:28:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:28:13 INFO - 'MOZ_NO_REMOTE': '1', 16:28:13 INFO - 'NO_EM_RESTART': '1', 16:28:13 INFO - 'PAGER': '/bin/cat', 16:28:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:28:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:28:13 INFO - 'PWD': '/builds/slave/test', 16:28:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:28:13 INFO - 'SHELL': '/bin/bash', 16:28:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6wKJUywe9t/Listeners', 16:28:13 INFO - 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/', 16:28:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:28:13 INFO - 'USER': 'cltbld', 16:28:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:28:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:28:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:13 INFO - 'XPC_FLAGS': '0x0', 16:28:13 INFO - 'XPC_SERVICE_NAME': '0', 16:28:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:28:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:28:13 INFO - Downloading/unpacking psutil>=3.1.1 16:28: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 16:28: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 16:28: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 16:28: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 16:28: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 16:28: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 16:28:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:28:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:28:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:28:16 INFO - Installing collected packages: psutil 16:28:16 INFO - Running setup.py install for psutil 16:28:16 INFO - building 'psutil._psutil_osx' extension 16:28:16 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 16:28:17 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 16:28:17 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 16:28:17 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 16:28:17 INFO - building 'psutil._psutil_posix' extension 16:28:17 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 16:28:17 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:28:17 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:28:17 INFO - ^ 16:28:17 INFO - 1 warning generated. 16:28:17 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 16:28:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:28:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:28:17 INFO - Successfully installed psutil 16:28:17 INFO - Cleaning up... 16:28:17 INFO - Return code: 0 16:28:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:28:17 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')]} 16:28:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:28:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:17 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')]} 16:28:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:28:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:17 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 0x10c6fd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c673570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd599ca1cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c511d30>, '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 0x10c377db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c509b20>, '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.2mHKXON1RT/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.6wKJUywe9t/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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 16:28:17 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 16:28:17 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 16:28:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2mHKXON1RT/Render', 16:28:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:28:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:28:17 INFO - 'HOME': '/Users/cltbld', 16:28:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:28:17 INFO - 'LOGNAME': 'cltbld', 16:28:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:28:17 INFO - 'MOZ_NO_REMOTE': '1', 16:28:17 INFO - 'NO_EM_RESTART': '1', 16:28:17 INFO - 'PAGER': '/bin/cat', 16:28:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:28:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:28:17 INFO - 'PWD': '/builds/slave/test', 16:28:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:28:17 INFO - 'SHELL': '/bin/bash', 16:28:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6wKJUywe9t/Listeners', 16:28:17 INFO - 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/', 16:28:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:28:17 INFO - 'USER': 'cltbld', 16:28:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:28:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:28:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:17 INFO - 'XPC_FLAGS': '0x0', 16:28:17 INFO - 'XPC_SERVICE_NAME': '0', 16:28:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:28:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:28:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:28:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:28:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:28:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:28:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:28:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:28:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:28:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:28:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:28:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:28:20 INFO - Installing collected packages: mozsystemmonitor 16:28:20 INFO - Running setup.py install for mozsystemmonitor 16:28:20 INFO - Successfully installed mozsystemmonitor 16:28:20 INFO - Cleaning up... 16:28:20 INFO - Return code: 0 16:28:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:28:20 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')]} 16:28:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:28:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:20 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')]} 16:28:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:28:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:20 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 0x10c6fd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c673570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd599ca1cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c511d30>, '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 0x10c377db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c509b20>, '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.2mHKXON1RT/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.6wKJUywe9t/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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 16:28:20 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 16:28:20 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 16:28:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2mHKXON1RT/Render', 16:28:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:28:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:28:20 INFO - 'HOME': '/Users/cltbld', 16:28:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:28:20 INFO - 'LOGNAME': 'cltbld', 16:28:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:28:20 INFO - 'MOZ_NO_REMOTE': '1', 16:28:20 INFO - 'NO_EM_RESTART': '1', 16:28:20 INFO - 'PAGER': '/bin/cat', 16:28:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:28:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:28:20 INFO - 'PWD': '/builds/slave/test', 16:28:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:28:20 INFO - 'SHELL': '/bin/bash', 16:28:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6wKJUywe9t/Listeners', 16:28:20 INFO - 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/', 16:28:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:28:20 INFO - 'USER': 'cltbld', 16:28:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:28:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:28:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:20 INFO - 'XPC_FLAGS': '0x0', 16:28:20 INFO - 'XPC_SERVICE_NAME': '0', 16:28:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:28:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:28:20 INFO - Downloading/unpacking jsonschema==2.5.1 16:28:20 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 16:28:20 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 16:28:20 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 16:28:20 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 16:28:20 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 16:28:20 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 16:28:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:28:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:28:23 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 16:28:23 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 16:28:23 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 16:28:23 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 16:28:23 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 16:28:23 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 16:28:23 INFO - Downloading functools32-3.2.3-2.tar.gz 16:28:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:28:23 INFO - warning: no files found matching '*.txt' 16:28:23 INFO - no previously-included directories found matching 'build' 16:28:23 INFO - no previously-included directories found matching 'dist' 16:28:23 INFO - no previously-included directories found matching '.git*' 16:28:23 INFO - Installing collected packages: jsonschema, functools32 16:28:23 INFO - Running setup.py install for functools32 16:28:23 INFO - warning: no files found matching '*.txt' 16:28:23 INFO - no previously-included directories found matching 'build' 16:28:23 INFO - no previously-included directories found matching 'dist' 16:28:23 INFO - no previously-included directories found matching '.git*' 16:28:23 INFO - Successfully installed jsonschema functools32 16:28:23 INFO - Cleaning up... 16:28:23 INFO - Return code: 0 16:28:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:28:23 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')]} 16:28:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:28:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:23 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')]} 16:28:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:28:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:23 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 0x10c6fd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c673570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd599ca1cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c511d30>, '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 0x10c377db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c509b20>, '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.2mHKXON1RT/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.6wKJUywe9t/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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 16:28:23 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 16:28:23 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 16:28:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2mHKXON1RT/Render', 16:28:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:28:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:28:23 INFO - 'HOME': '/Users/cltbld', 16:28:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:28:23 INFO - 'LOGNAME': 'cltbld', 16:28:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:28:23 INFO - 'MOZ_NO_REMOTE': '1', 16:28:23 INFO - 'NO_EM_RESTART': '1', 16:28:23 INFO - 'PAGER': '/bin/cat', 16:28:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:28:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:28:23 INFO - 'PWD': '/builds/slave/test', 16:28:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:28:23 INFO - 'SHELL': '/bin/bash', 16:28:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6wKJUywe9t/Listeners', 16:28:23 INFO - 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/', 16:28:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:28:23 INFO - 'USER': 'cltbld', 16:28:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:28:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:28:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:23 INFO - 'XPC_FLAGS': '0x0', 16:28:23 INFO - 'XPC_SERVICE_NAME': '0', 16:28:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:28:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:28:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:28:24 INFO - Cleaning up... 16:28:24 INFO - Return code: 0 16:28:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:28: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')]} 16:28:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:28:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28: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')]} 16:28:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:28:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28: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', '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 0x10c6fd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c673570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd599ca1cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c511d30>, '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 0x10c377db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c509b20>, '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.2mHKXON1RT/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.6wKJUywe9t/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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 16:28: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:28: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 blobuploader==1.2.4 16:28:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2mHKXON1RT/Render', 16:28:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:28:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:28:24 INFO - 'HOME': '/Users/cltbld', 16:28:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:28:24 INFO - 'LOGNAME': 'cltbld', 16:28:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:28:24 INFO - 'MOZ_NO_REMOTE': '1', 16:28:24 INFO - 'NO_EM_RESTART': '1', 16:28:24 INFO - 'PAGER': '/bin/cat', 16:28:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:28:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:28:24 INFO - 'PWD': '/builds/slave/test', 16:28:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:28:24 INFO - 'SHELL': '/bin/bash', 16:28:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6wKJUywe9t/Listeners', 16:28:24 INFO - 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/', 16:28:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:28:24 INFO - 'USER': 'cltbld', 16:28:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:28:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:28:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:24 INFO - 'XPC_FLAGS': '0x0', 16:28:24 INFO - 'XPC_SERVICE_NAME': '0', 16:28:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:28:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:28:24 INFO - Downloading/unpacking blobuploader==1.2.4 16:28:24 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 16:28:24 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 16:28:24 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 16:28:24 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 16:28:24 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 16:28:24 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 16:28:26 INFO - Downloading blobuploader-1.2.4.tar.gz 16:28:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:28:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:28:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:28:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:28:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:28:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:28:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:28:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:28:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:28:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:28:27 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 16:28:27 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 16:28:27 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 16:28:27 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 16:28:27 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 16:28:27 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 16:28:28 INFO - Downloading docopt-0.6.1.tar.gz 16:28:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:28:28 INFO - Installing collected packages: blobuploader, requests, docopt 16:28:28 INFO - Running setup.py install for blobuploader 16:28:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:28:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:28:28 INFO - Running setup.py install for requests 16:28:28 INFO - Running setup.py install for docopt 16:28:28 INFO - Successfully installed blobuploader requests docopt 16:28:28 INFO - Cleaning up... 16:28:29 INFO - Return code: 0 16:28:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:28:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:28:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:28:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:29 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 0x10c6fd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c673570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd599ca1cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c511d30>, '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 0x10c377db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c509b20>, '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.2mHKXON1RT/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.6wKJUywe9t/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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 16:28:29 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 16:28:29 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 16:28:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2mHKXON1RT/Render', 16:28:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:28:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:28:29 INFO - 'HOME': '/Users/cltbld', 16:28:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:28:29 INFO - 'LOGNAME': 'cltbld', 16:28:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:28:29 INFO - 'MOZ_NO_REMOTE': '1', 16:28:29 INFO - 'NO_EM_RESTART': '1', 16:28:29 INFO - 'PAGER': '/bin/cat', 16:28:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:28:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:28:29 INFO - 'PWD': '/builds/slave/test', 16:28:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:28:29 INFO - 'SHELL': '/bin/bash', 16:28:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6wKJUywe9t/Listeners', 16:28:29 INFO - 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/', 16:28:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:28:29 INFO - 'USER': 'cltbld', 16:28:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:28:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:28:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:29 INFO - 'XPC_FLAGS': '0x0', 16:28:29 INFO - 'XPC_SERVICE_NAME': '0', 16:28:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:28:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:28:29 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-xrV9Mu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:28:29 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-1nA1f9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:28:29 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-spQ1bd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:28:29 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-C0IJ7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:28:29 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-0s1s4T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:28:29 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-oM9R6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:28:29 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-Xd1_Ya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:28:30 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-NhQs0Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:28:30 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-OpXpLH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:28:30 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-2PuXBP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:28:30 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-H2zKnv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:28:30 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-x8nD2b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:28:30 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-NeOjtR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:28:30 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-JvnoaC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:28:30 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-XhcaH3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:28:30 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-5GxoV9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:28:30 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-mbsHbA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:28:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:28:31 INFO - Running setup.py install for manifestparser 16:28:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:28:31 INFO - Running setup.py install for mozcrash 16:28:31 INFO - Running setup.py install for mozdebug 16:28:31 INFO - Running setup.py install for mozdevice 16:28:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:28:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:28:31 INFO - Running setup.py install for mozfile 16:28:31 INFO - Running setup.py install for mozhttpd 16:28:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:28:31 INFO - Running setup.py install for mozinfo 16:28:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:28:32 INFO - Running setup.py install for mozInstall 16:28:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:28:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:28:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:28:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:28:32 INFO - Running setup.py install for mozleak 16:28:32 INFO - Running setup.py install for mozlog 16:28:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:28:32 INFO - Running setup.py install for moznetwork 16:28:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:28:32 INFO - Running setup.py install for mozprocess 16:28:32 INFO - Running setup.py install for mozprofile 16:28:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:28:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:28:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:28:33 INFO - Running setup.py install for mozrunner 16:28:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:28:33 INFO - Running setup.py install for mozscreenshot 16:28:33 INFO - Running setup.py install for moztest 16:28:33 INFO - Running setup.py install for mozversion 16:28:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:28:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:28:33 INFO - Cleaning up... 16:28:33 INFO - Return code: 0 16:28:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:28:33 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')]} 16:28:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:28:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:33 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')]} 16:28:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:28:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:33 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 0x10c6fd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c673570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd599ca1cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c511d30>, '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 0x10c377db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c509b20>, '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.2mHKXON1RT/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.6wKJUywe9t/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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 16:28:33 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 16:28:33 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 16:28:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2mHKXON1RT/Render', 16:28:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:28:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:28:33 INFO - 'HOME': '/Users/cltbld', 16:28:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:28:33 INFO - 'LOGNAME': 'cltbld', 16:28:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:28:33 INFO - 'MOZ_NO_REMOTE': '1', 16:28:33 INFO - 'NO_EM_RESTART': '1', 16:28:33 INFO - 'PAGER': '/bin/cat', 16:28:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:28:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:28:33 INFO - 'PWD': '/builds/slave/test', 16:28:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:28:33 INFO - 'SHELL': '/bin/bash', 16:28:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6wKJUywe9t/Listeners', 16:28:33 INFO - 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/', 16:28:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:28:33 INFO - 'USER': 'cltbld', 16:28:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:28:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:28:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:33 INFO - 'XPC_FLAGS': '0x0', 16:28:33 INFO - 'XPC_SERVICE_NAME': '0', 16:28:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:28:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:28:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:28:33 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-8QrP98-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:28:34 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)) 16:28:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:28:34 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-4N08Pd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:28:34 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)) 16:28:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:28:34 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-iVgu5T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:28:34 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)) 16:28:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:28:34 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-gWDwa6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:28:34 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)) 16:28:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:28:34 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-JAEbob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:28:34 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)) 16:28:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:28:34 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-T92SuN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:28:34 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)) 16:28:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:28:34 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-49aVDR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:28:34 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)) 16:28:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:28:34 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-G7fiu8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:28:34 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)) 16:28:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:28:34 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-DC3sCQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:28:34 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)) 16:28:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:28:34 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-a1FY0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:28:34 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)) 16:28:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:28:34 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-h0oWMz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:28:35 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)) 16:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:28:35 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-t3PMrp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:28:35 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)) 16:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:28:35 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-A8C1sU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:28:35 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)) 16:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:28:35 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-N4sUD8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:28:35 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)) 16:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:28:35 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-hBOdjC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:28:35 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)) 16:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:28:35 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-_JhDlB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:28:35 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)) 16:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:28:35 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-RfSkQt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:28:35 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)) 16:28:35 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)) 16:28:35 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)) 16:28:35 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)) 16:28:35 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)) 16:28:35 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)) 16:28:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:28:35 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 16:28:35 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 16:28:35 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 16:28:35 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 16:28:35 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 16:28:35 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 16:28:38 INFO - Downloading blessings-1.6.tar.gz 16:28:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:28:38 INFO - Installing collected packages: blessings 16:28:38 INFO - Running setup.py install for blessings 16:28:38 INFO - Successfully installed blessings 16:28:38 INFO - Cleaning up... 16:28:38 INFO - Return code: 0 16:28:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:28:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:28:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:28:38 INFO - Reading from file tmpfile_stdout 16:28:38 INFO - Current package versions: 16:28:38 INFO - blessings == 1.6 16:28:38 INFO - blobuploader == 1.2.4 16:28:38 INFO - docopt == 0.6.1 16:28:38 INFO - functools32 == 3.2.3-2 16:28:38 INFO - jsonschema == 2.5.1 16:28:38 INFO - manifestparser == 1.1 16:28:38 INFO - mozInstall == 1.12 16:28:38 INFO - mozcrash == 0.17 16:28:38 INFO - mozdebug == 0.1 16:28:38 INFO - mozdevice == 0.48 16:28:38 INFO - mozfile == 1.2 16:28:38 INFO - mozhttpd == 0.7 16:28:38 INFO - mozinfo == 0.9 16:28:38 INFO - mozleak == 0.1 16:28:38 INFO - mozlog == 3.4 16:28:38 INFO - moznetwork == 0.27 16:28:38 INFO - mozprocess == 0.23 16:28:38 INFO - mozprofile == 0.28 16:28:38 INFO - mozrunner == 6.12 16:28:38 INFO - mozscreenshot == 0.1 16:28:38 INFO - mozsystemmonitor == 0.3 16:28:38 INFO - moztest == 0.7 16:28:38 INFO - mozversion == 1.4 16:28:38 INFO - psutil == 3.1.1 16:28:38 INFO - requests == 1.2.3 16:28:38 INFO - wsgiref == 0.1.2 16:28:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:28:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:28:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:28:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:38 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 0x10c6fd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c673570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd599ca1cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c511d30>, '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 0x10c377db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c509b20>, '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.2mHKXON1RT/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.6wKJUywe9t/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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 16:28:38 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 16:28:38 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 16:28:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2mHKXON1RT/Render', 16:28:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:28:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:28:38 INFO - 'HOME': '/Users/cltbld', 16:28:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:28:38 INFO - 'LOGNAME': 'cltbld', 16:28:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:28:38 INFO - 'MOZ_NO_REMOTE': '1', 16:28:38 INFO - 'NO_EM_RESTART': '1', 16:28:38 INFO - 'PAGER': '/bin/cat', 16:28:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:28:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:28:38 INFO - 'PWD': '/builds/slave/test', 16:28:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:28:38 INFO - 'SHELL': '/bin/bash', 16:28:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6wKJUywe9t/Listeners', 16:28:38 INFO - 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/', 16:28:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:28:38 INFO - 'USER': 'cltbld', 16:28:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:28:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:28:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:38 INFO - 'XPC_FLAGS': '0x0', 16:28:38 INFO - 'XPC_SERVICE_NAME': '0', 16:28:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:28:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:28:39 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)) 16:28:39 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)) 16:28:39 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)) 16:28:39 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)) 16:28:39 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)) 16:28:39 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)) 16:28:39 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)) 16:28:39 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)) 16:28:39 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)) 16:28:39 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)) 16:28:39 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)) 16:28:39 INFO - Cleaning up... 16:28:39 INFO - Return code: 0 16:28:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:28:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:28:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:28:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:28:39 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 0x10c6fd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c673570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd599ca1cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c511d30>, '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 0x10c377db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c509b20>, '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.2mHKXON1RT/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.6wKJUywe9t/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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 16:28:39 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 16:28:39 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 16:28:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2mHKXON1RT/Render', 16:28:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:28:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:28:39 INFO - 'HOME': '/Users/cltbld', 16:28:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:28:39 INFO - 'LOGNAME': 'cltbld', 16:28:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:28:39 INFO - 'MOZ_NO_REMOTE': '1', 16:28:39 INFO - 'NO_EM_RESTART': '1', 16:28:39 INFO - 'PAGER': '/bin/cat', 16:28:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:28:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:28:39 INFO - 'PWD': '/builds/slave/test', 16:28:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:28:39 INFO - 'SHELL': '/bin/bash', 16:28:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6wKJUywe9t/Listeners', 16:28:39 INFO - 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/', 16:28:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:28:39 INFO - 'USER': 'cltbld', 16:28:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:28:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:28:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:28:39 INFO - 'XPC_FLAGS': '0x0', 16:28:39 INFO - 'XPC_SERVICE_NAME': '0', 16:28:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:28:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:28:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:28:39 INFO - Cleaning up... 16:28:39 INFO - Return code: 0 16:28:39 INFO - Running post-action listener: _resource_record_post_action 16:28:39 INFO - Running post-action listener: _start_resource_monitoring 16:28:39 INFO - Starting resource monitoring. 16:28:39 INFO - [mozharness: 2016-10-04 23:28:39.356547Z] Finished create-virtualenv step (success) 16:28:39 INFO - [mozharness: 2016-10-04 23:28:39.357548Z] Running install step. 16:28:39 INFO - Running pre-action listener: _resource_record_pre_action 16:28:39 INFO - Running main action method: install 16:28:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:28:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:28:39 INFO - Reading from file tmpfile_stdout 16:28:39 INFO - Detecting whether we're running mozinstall >=1.0... 16:28:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:28:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:28:39 INFO - Reading from file tmpfile_stdout 16:28:39 INFO - Output received: 16:28:39 INFO - Usage: mozinstall [options] installer 16:28:39 INFO - Options: 16:28:39 INFO - -h, --help show this help message and exit 16:28:39 INFO - -d DEST, --destination=DEST 16:28:39 INFO - Directory to install application into. [default: 16:28:39 INFO - "/builds/slave/test"] 16:28:39 INFO - --app=APP Application being installed. [default: firefox] 16:28:39 INFO - mkdir: /builds/slave/test/build/application 16:28:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 16:28:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 16:29:11 INFO - Reading from file tmpfile_stdout 16:29:11 INFO - Output received: 16:29:11 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 16:29:11 INFO - Running post-action listener: _resource_record_post_action 16:29:11 INFO - [mozharness: 2016-10-04 23:29:11.444709Z] Finished install step (success) 16:29:11 INFO - [mozharness: 2016-10-04 23:29:11.444840Z] Running run-tests step. 16:29:11 INFO - Running pre-action listener: _resource_record_pre_action 16:29:11 INFO - Running main action method: run_tests 16:29:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:29:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:29:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:29:11 INFO - 2016-10-04 16:29:11.459 screenresolution[1924:9452] starting screenresolution argv=screenresolution get 16:29:11 INFO - 2016-10-04 16:29:11.462 screenresolution[1924:9452] Display 0: 1600x1200x32@60 16:29:11 INFO - 2016-10-04 16:29:11.467 screenresolution[1925:9454] starting screenresolution argv=screenresolution list 16:29:11 INFO - Available Modes on Display 0 16:29:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:29:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:29:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:29:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:29:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:29:11 INFO - Intel Iris: 16:29:11 INFO - Chipset Model: Intel Iris 16:29:11 INFO - Type: GPU 16:29:11 INFO - Bus: Built-In 16:29:11 INFO - VRAM (Dynamic, Max): 1536 MB 16:29:11 INFO - Vendor: Intel (0x8086) 16:29:11 INFO - Device ID: 0x0a2e 16:29:11 INFO - Revision ID: 0x0009 16:29:11 INFO - Displays: 16:29:11 INFO - Display: 16:29:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:29:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:29:11 INFO - Display Serial Number: 1600x1200 60 16:29:11 INFO - Main Display: Yes 16:29:11 INFO - Mirror: Off 16:29:11 INFO - Online: Yes 16:29:11 INFO - Rotation: Supported 16:29:11 INFO - Return code: 0 16:29:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:29:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:29:11 INFO - Python 2.7.3 16:29:11 INFO - Return code: 0 16:29:11 INFO - grabbing minidump binary from tooltool 16:29:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:29:11 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 0x10c511d30>, '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 0x10c377db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c509b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:29:11 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 16:29:11 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 16:29:11 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 16:29:11 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:29:11 INFO - Return code: 0 16:29:11 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:29:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:29:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:29:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:29:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:29:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NatTCfiTR2C6PcYNvCwB4Q/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0369', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 16:29:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NatTCfiTR2C6PcYNvCwB4Q/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0369 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 16:29:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2mHKXON1RT/Render', 16:29:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:29:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:29:11 INFO - 'HOME': '/Users/cltbld', 16:29:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:29:11 INFO - 'LOGNAME': 'cltbld', 16:29:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:29:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:29:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:11 INFO - 'MOZ_NO_REMOTE': '1', 16:29:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:29:11 INFO - 'NO_EM_RESTART': '1', 16:29:11 INFO - 'PAGER': '/bin/cat', 16:29:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:29:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:29:11 INFO - 'PWD': '/builds/slave/test', 16:29:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:29:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:29:11 INFO - 'SHELL': '/bin/bash', 16:29:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6wKJUywe9t/Listeners', 16:29:11 INFO - 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/', 16:29:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:29:11 INFO - 'USER': 'cltbld', 16:29:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:29:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:29:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:29:11 INFO - 'XPC_FLAGS': '0x0', 16:29:11 INFO - 'XPC_SERVICE_NAME': '0', 16:29:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:29:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NatTCfiTR2C6PcYNvCwB4Q/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0369', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 16:29:12 INFO - mozversion application_buildid: 20161004141800 16:29:12 INFO - mozversion application_changeset: 43c3d294f63cd8e49fca491a686f729cfd66a365 16:29:12 INFO - mozversion application_display_name: FirefoxDeveloperEdition 16:29:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:29:12 INFO - mozversion application_name: Firefox 16:29:12 INFO - mozversion application_remotingname: firefox-dev 16:29:12 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:29:12 INFO - mozversion application_vendor: Mozilla 16:29:12 INFO - mozversion application_version: 51.0a2 16:29:12 INFO - mozversion platform_buildid: 20161004141800 16:29:12 INFO - mozversion platform_changeset: 43c3d294f63cd8e49fca491a686f729cfd66a365 16:29:12 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:29:12 INFO - mozversion platform_version: 51.0a2 16:29:12 INFO - using testdate: 1475623752 16:29:12 INFO - actual date: 1475623752 16:29:12 INFO - starting webserver on 'localhost:49462' 16:29:12 INFO - SUITE-START | Running 2 tests 16:29:12 INFO - TEST-START | dromaeo_css 16:29:12 INFO - operating with platform_type : mac_ 16:29:12 INFO - Initialising browser for dromaeo_css test... 16:29:12 INFO - TEST-INFO | started process 1935 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/tmpuCOB0_/profile http://localhost:49462/getInfo.html) 16:29:14 INFO - PROCESS | 1935 | __metrics Screen width/height:1600/1200 16:29:14 INFO - PROCESS | 1935 | colorDepth:24 16:29:14 INFO - PROCESS | 1935 | Browser inner width/height: 1024/689 16:29:14 INFO - PROCESS | 1935 | __metrics 16:29:14 ERROR - PROCESS | 1935 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 16:29:15 INFO - TEST-INFO | 1935: exit 0 16:29:15 INFO - Browser initialized. 16:29:15 INFO - Running cycle 1/1 for dromaeo_css test... 16:29:15 INFO - TEST-INFO | started process 1938 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/tmpuCOB0_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:29:27 INFO - PROCESS | 1938 | RSS: Main: 224997376 16:29:27 INFO - PROCESS | 1938 | 16:30:17 INFO - PROCESS | 1938 | 1475623817220 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] 16:32:29 INFO - PROCESS | 1938 | Cycle 1(1): loaded http://localhost:49462/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49462/tests/dromaeo/cssquery-ext.html) 16:32:30 INFO - PROCESS | 1938 | RSS: Main: 237551616 16:32:30 INFO - PROCESS | 1938 | 16:35:32 INFO - PROCESS | 1938 | Cycle 1(1): loaded http://localhost:49462/tests/dromaeo/cssquery-ext.html (next: http://localhost:49462/tests/dromaeo/cssquery-jquery.html) 16:35:33 INFO - PROCESS | 1938 | RSS: Main: 248479744 16:35:33 INFO - PROCESS | 1938 | 16:38:35 INFO - PROCESS | 1938 | Cycle 1(1): loaded http://localhost:49462/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49462/tests/dromaeo/cssquery-mootools.html) 16:38:36 INFO - PROCESS | 1938 | RSS: Main: 250867712 16:38:36 INFO - PROCESS | 1938 | 16:41:37 INFO - PROCESS | 1938 | Cycle 1(1): loaded http://localhost:49462/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49462/tests/dromaeo/cssquery-prototype.html) 16:41:38 INFO - PROCESS | 1938 | RSS: Main: 251187200 16:41:38 INFO - PROCESS | 1938 | 16:44:41 INFO - PROCESS | 1938 | Cycle 1(1): loaded http://localhost:49462/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49462/tests/dromaeo/cssquery-yui.html) 16:44:41 INFO - PROCESS | 1938 | RSS: Main: 255602688 16:44:41 INFO - PROCESS | 1938 | 16:47:44 INFO - PROCESS | 1938 | Cycle 1(1): loaded http://localhost:49462/tests/dromaeo/cssquery-yui.html (next: http://localhost:49462/tests/dromaeo/cssquery-dojo.html) 16:47:44 INFO - PROCESS | 1938 | RSS: Main: 257302528 16:47:44 INFO - PROCESS | 1938 | 16:47:44 INFO - PROCESS | 1938 | __start_tp_report 16:47:44 INFO - PROCESS | 1938 | _x_x_mozilla_page_load 16:47:44 INFO - PROCESS | 1938 | _x_x_mozilla_page_load_details 16:47:44 INFO - PROCESS | 1938 | |i|pagename|runs| 16:47:44 INFO - PROCESS | 1938 | |0;dojo.html;3056.327607926258;3353.547271118399;3452.4476083826576;3466.9653303466976;3501.859925602976;4701.341812146302;5937;5948.791792287271;5962.791302304426;5994.490468310188;5796.652200867951;5865.002949498585;5914.4085591440835;5920.023196172627;5935.198748168996;5387.19192121183;5397.649152805075;5453.672779633215;5456.727163641822;5459.508644222019;5448.91826622601;5473.945260547403;5474.945250547503;5486.396496385394;5526.309211348582;5344.171653393731;5394.703291318995;5440.401555828876;5456.8090116845915;5460.399356070829;5299.920501192485;5352.277442545265;5397.919031214535;5407.594430417735;5409.918851217235;5319.17552779316;5345.198220266952;5360.16917377807;5431.348238211401;5450.937067271883;5758.88482230353;6008.309044459899;6032.547558933097;6064.54515911304;6093;6203.162573052626;6261.499080073629;6282.277538083134;6331.651759153245;6350.809475715736;6351.9364806351805;6363.61818290904;6371;6405.711742971577;6411.4229719325485;5848.356680765112;5884.352721200665;5933.465988061095;6003.549733769941;6031.45716885478;6025.307089684655;6060.121282414026;6385.48916086712;6440;6491.188601424822;4595.494495605481;5581.916271255935;6279.152314437584;6309.779157729457;6332.6200427973545;5145.3568303962;6203.131561581382;6338.714757835908;6391.840203994937;6457.5479716419395;6224.128621992924;6275.529335299871;6292.867283888944;6306.905396419057;6355.396237357444;5470.863228419322;5611.663300202001;6272.40412160844;6335.588186767845;6371.52213583983;4915.26271059344;5046.041252162077;5049.343585333883;5049.394072711299;5062.7215503146945;4408.955910440919;4449.555044495589;4464.531224221475;4492.191405547033;4554.726716396961;5171.922421163686;5978.940210597925;6053.303870054912;6064.696765161724;6112.052631842072;5764.250647415893;6198.566100372931;6225.84821807967;6250.6874656267;6313.652749098752;6009.038553831366;6029.125776762433;6087.208662873798;6113.719560719409;6144.600600960924;5510.614257001971;5547.945890280834;5564.137558678412;5565.610407271533;5584.91622625661;6547.148870646785;6555.311692272434;6596.67016649156;6603;6619.86760264792;6185.907211391743;6207.410296021871;6216.44052035319;6234.345393733593;6235.220597425322;6541.149650545399;6558.672066396565;6561;6561.475081993524;6568.047633093079;6253.687315634291;6287.46556542699;6328.398802113792;6329.430351268408;6364.872702546016;6080.118382834376;6219.47134493555;6223.688815559294;6236.532260080603;6385.074164246251;6307.90538141919;6321.367863213642;6327.303996560467;6328.145700330397;6341.841453963688;6300.621962682254;6302.621842689453;6304.527160463075;6311.179546658905;6319.715612797343;5822.592418530662;6119.204503414528;6134.693265336626;6182.412670796267;6238.313785483502;6194.256689197326;6248.843778905563;6283.120363149254;6319.146915166578;6323.462505687068;6140.078988151813;6204.038374052029;6211.409916057967;6232.376762323732;6236.812895613139 16:47:44 INFO - PROCESS | 1938 | |1;ext.html;517.1776874769117;523.8768889311011;531.9255304257405;542.3356388424179;573.7332140554641;38266;40631.39052914205;40804.795976020076;40824.79587602065;40845.79577102114;41241;41740;41781.79109104458;41794.791026044906;41839;9540.80918381632;9741.31810773246;9759.804803903917;9776.071273229032;9791.020897910223;8808.911910880874;9040.231580315649;9786.510674466284;9853.852192217122;9894.060064293917;9774.706758797212;9864;9872.16086632637;9874.851877221847;9888;8241.793955151139;9797.853032204523;9845.409275443424;9852.95073524635;9856.90143098567;9606;9672.371295865747;9679.467629280387;9700.223982081416;9701.611935522642;39596;39665;39789.20421591552;39973;40864.59135408638;2650.509655713699;3175.539546765706;3179.332340208559;3209.1977005748563;3214.758893083028;30567.69432305693;30820.2294942626;31099.06702798897;31586.684133158604;31834.363312733847;3213.2127628730877;3264.5919260092487;3311.1556553079054;3312.6190488093935;3411.8805841795665;504470;517019;539160;539549;540466;32490.512642310383;60687;60819.087713684334;61043.77912441726;61481.69259153765;34489.482657760156;35378.93863184108;35588.28823423569;35830.387632556594;35857.64142358543;15006.249687515581;15141.394344226108;15155.924220378827;15163.848361516464;15173.696526069416;12741.044421668412;12847.394075740533;12853.614391568268;12884.871151288555;12901.870981290254;7733.845323093619;7737.690492380354;7737.806554836174;7783.727569535153;7826.569538675313;3253.121657152603;3280.155061875643;3289.4079065767914;3303.339332133583;3308.073739352937;894.7718331825342;917.4082716647724;937.9108984646448;973.634886917406;1006.9678579456116;23368.76631233666;30087.548686769715;30475;30706.232344191572;30875;933.5425641435784;940.9978373032699;1005.949702514886;1034.5809946971488;1114.2534501883758;15338.693226135638;15739.291731872094;15895.761563576556;15961;16255.51233462998;752119;776470;777203;778794;782058;47184;57579.424205758245;57910.13134802981;58105;58342.41657583455;1277.131550545638;1309.0967232609469;1326.1777697827408;1331.4141777617817;1333.686583652841;29156.562651560667;29724.405511890072;30093;30304.696953030187;30598.776048957792;51114;51294.230586540485;51332.74333628308;51421.74289128531;51527;540806;542132.2893385508;658859;659778;661277;20224.393268201977;22100.77899220987;23160.3051908443;24716.629250560898;26939.326516837235;46980.53019469762;47744;48062.03875922392;48300.758496207294;48345;38609.613903861726;39480.40779388369;39771.60228397795;39841;40906.59093409028;38601.8419447417;39626.40560391539;40514.59485405226;40646.59353406546;41159.7942010288;37437;38095.619043810315;38298.425523616614;38442.615573845025;39018.41472377974;33691;34399.484007739404;34833.825830870686;35095.649043509235;35394;25687.871560642077;26013.609795853456;26066.478670426866;26484.867575662;26756.92972281165 16:47:44 INFO - PROCESS | 1938 | |2;jquery.html;320.64728798321846;380.83624041662074;382.8698242597518;390.6835463274746;406.8080524064492;19441.319553815618;20193.49516262094;20197;20542.38372848813;20798.06408711608;19761.802381976177;19897.00514974249;20238.29165979191;20496.487587810312;20797.584048319062;5351.849352389236;5812.070068788995;5975.52195824333;6020.187274717922;6024.397560243984;6002.189704389917;6016.789412370568;6082.635041897501;6098.481629061535;6113.602615829979;6027.789027384042;6307.990721484563;6645.501587380942;6678.031685405614;6773.559718618274;6050.2437195350585;6183.81448556544;6674.93325066748;6698.961660942562;6717.6977036033495;5888.146218798293;5910.881782364371;5917.14201440793;5923.674197919113;5924.259467566554;11990.220635658741;12174.756504869942;12259.69350766229;12314.891659750576;12328.32194229317;1986.4437957371958;2090.6654935210295;2111.2399536166968;2153.321703663341;2199.8570092943905;9953.850692239623;10005;10131.493425328777;10284.691459256233;10434.79130417395;1905.8856468611928;1970.4581240158927;1975.338261682338;1989.7512810898638;1998.860079794415;76435;122997;125704;134621;135821.3208933949;11417.828732569018;11656.067514598812;11670.94164529172;11817.64097128824;11916.821247681291;11898;11960.40197990097;14600.634984125269;14736.48422305214;14753.631159221106;8511.233988941025;8712.91287087121;8726.607302671395;8845.823083538293;8850;8695.173958473935;8737.43206691563;8737.694180703773;8881.911180888237;8888.24449921751;4491.393661855673;4516.23224051912;4563.269876819693;4573.977130114395;4611.1469378164475;1921.2795201799324;1971.39872338938;1973.190991693399;1982.415187519685;2038.5718999010078;802.334062727946;878.2052242720348;953.0421925964362;959.7456673981261;974.9951250243845;15752.76370854438;20416.387508374773;20533.2813351532;20747.896260518904;21631.89184054101;738.4683028219673;799.3325573146487;881.7487016200353;933.5239028095721;943.7451887990204;8445.57772111392;8471.830563388698;8755.868661970075;9120.771980700536;11338.206325557132;535180;620782;626202;626343;640939;128192;128737;136596;149353.25323373312;159867.20066399826;932.5570354081892;953.1516949914582;960.490939801906;969.0890562870878;972.2027937091517;16242.675146496767;19028.858268503933;19631.214751409785;19820;19832.40502784919;56481.43518564762;57219;58074;58281.12578311244;58610.413895860496;59440.70279648574;79059;81119;84496.31007379941;86546;8007.263994601455;8047.114817370201;8288.461250018729;8355.95822020886;8431.620577074169;10907.345559266469;13258.801117983045;13446.46214151423;13547.86452135466;13688.315584220949;11443.370614616277;11487.770244595229;11536.59621913229;11674.94162529182;11764.82352764692;11047;11415.885841141482;11500.82748758786;11578.189526733047;11722.296662200295;5842.919059973919;8227.588620569068;10109.73628296463;11621.28403697227;11965.700857478632;7659.578723170279;8016.559089250147;8342.666293348198;8386.28716559075;8654.437461564978;10315.658964334589;10721.892781072402;11038.337699738042;11456.713582160513;11490.965813076864 16:47:44 INFO - PROCESS | 1938 | |3;mootools.html;1502.0462006625792;1536.431520337475;1584.8652864506516;1700.3793615330408;1843.216632931004;8130.878036829452;8373.497590144596;8588.527630980294;9181.081891810823;9182.173604375605;8581.613827377767;8882.378233523656;8894.977077636075;8972.685955991541;8999.685011024616;2374.7506511816227;2421.3462365161395;2425.2845410603827;2426.720927093389;2431.57447446697;2373.537160253751;2405.1822380390663;2409.4819613783034;2410.505846301504;2412.384841865322;2417.867017314047;2420.1166574200465;2422.39440139965;2426.3085020769086;2434.42790944128;2105.263157894732;2379.8691071991034;2395.125779090628;2404.014354114822;2409.229046705055;2384.511175209078;2396.0535588442467;2411.0837881605053;2412.9034838606435;2414.9275521734376;8032.9557157569725;8531.360147988864;8971.237444817198;9051.27589792815;9068.68259610917;5278.392984806758;5427.728613569306;5434.701091439969;5444.210589464506;5451.209574611659;3116.4702000659718;3663.010987033486;3676.099355657881;3742.6631603155847;3743.026813028605;1025.220832167558;1052.1898138433364;1084.1218612923558;1102.85662863828;1107.0036966729926;11856.585019524362;11876.524939002516;11900.583479578174;11985.700357491045;12058.69853253667;3894.279558281727;4306.41863348444;4768.499307572724;4806.711597304173;4961.90076198474;8959.462432254086;10011.199104071657;10132.797344053077;10133.594656213816;10138.543765530569;5401.838604700009;5406.08096623575;5412.161115027177;5418.972905135449;5424.755885985141;4462.933056004163;4582.95417045832;4748.382710247714;4817.108834865561;4936.3829521309835;3409.403354412968;3996.86010989614;4104.753714777123;4126.66986641068;4141.233871733739;1320.940557674907;1323.133347657286;1331.9267440290878;1339.1830983100301;1342.1477361875084;791.8139237279235;798.8641930871765;920.889493260813;933.4632586262791;939.8637197606308;5027.245913113063;5851.941480585139;5855.414458554195;6036.849078773066;6067.211262535842;432.86148432501926;438.5723919178775;452.15221459762944;454.64991956194206;457.2957645226381;3939.38485221058;3973.324534829086;3986.980065099656;4038.495188101487;4123.670106391542;10646.787064258671;10933.398663073449;10948.671539853816;10958.780824383468;11084.445777711244;10897.509612067475;10949.397783122005;10965.342079475256;10990.230683852054;11005.669829905115;8245.670173193124;8267.173282671685;8317.376196785144;8343.415960882801;8348.582570871433;4521.977390113028;5048.368953880765;5911.083782013795;6085.574009819447;6159.599626024294;9958.402495850272;10132.89867101349;10175.491225438847;10237.897621023694;10340.37957722539;9717.951410242904;10033.598656053968;10350.948245258725;10395.792084158425;10508.894911051097;7618;7619.885701714589;7665.846683066419;7696.230376962483;7723.150453450004;8337.499750014777;8343.332533397435;8418.98972123349;8419.579021048801;8423.241908228289;7468.2158373372185;7532.698692052257;7597.544147351176;7681.884771728541;7733.961330193538;5917.940820591739;7384.741534046282;7464.552126872405;7603.20166382544;7632.19861914491;7024.859502810017;7064.258252883374;7090.858182836418;7123.430125590044;7131.500794944304;4329.935050974175;4481.955180448153;5041.823536176216;5101.974490127525;5151.433342332265;4439.112177564564;4964.702117872939;5088.898222035613;5153.7680804364645;5258.263843061898 16:47:44 INFO - PROCESS | 1938 | |4;prototype.html;270.6319405608373;300.9172477568667;305.4623862002875;311.1490074645845;323.3532934131737;5266.789328426863;5353.437889021655;5444.428335024815;5612.915806262904;5705.857353566158;4977.038661996106;5268.92096618551;5427.3215848019;5462.235287059805;5496.80761173358;3632.945505817415;3868.9226215475674;3983.9800800996027;4159.688023398242;4163.333866581347;3915.7650540967493;4090.4477895484174;4149.9792501037455;4283.121959998209;4293.785310734466;3587.856485740567;4092.1611069730634;4105.158442519277;4124.298869192229;4151.4395556599775;4134.036332741954;4151.937720934188;4181.498220213563;4202.537720850704;4214.4195926527555;3209.582754241957;3256.0394683568406;3566.8394922228563;3600.4419315006216;3603.7837729736298;4514.390557274792;4758.904821903542;5057.671251368686;5333.733313334318;5434.266374039533;4164.375343698439;4194.391813187101;4745.667803253774;4755.690880092783;4781.474037855833;5821.912671309934;5822.621529600562;5839.649621022752;5843.5033022193165;5849.707514624251;3565.94651080234;3669.8348574313954;3896.707746918964;3902.921941561153;3906.980465097685;6074.96962515189;6095.207623008981;6098.847528811771;6122.8775424491705;6153.446189842935;3985.163115745726;3991.964098309883;3999.1002024544828;3999.2001599679597;4033;3754.948614387976;3841.7153333899673;4042.757434553936;4055.47278853753;4061.5126184858004;4716.891530490332;4729.69256998294;4749.311349854321;4769.689970151929;4786.210275304606;4758.952410475851;4832.975835120802;4896.436909755353;5926.67403292823;5991.580589358703;1151.7811615792973;1176.4000359816384;1303.8696130386886;1304.1860003473935;1359.6125104345215;816.9632366543519;832.0805509911581;848.762346542969;850.5619605902965;853.4836423963537;3994.2410941920944;4191.841201781085;4257.638100761408;4547.727136371828;4606.470255920545;4598.218302888517;5009.320013792603;5058.570021548209;5069.518395752398;5121.923171152435;3825.139343647713;4161.8370038770145;4459.375687403766;4634.6987445816585;4664.55686709762;2261.5024694567496;2265.59219340517;2494.1893884487613;2643.7488438598302;2657.870405077834;4833.438277712818;4908.226851828706;5180.740962951837;5203.16749320107;5311.892542862469;4152.754173747863;4419.1382680377665;4425.026494171278;4704.553067458586;4890.486498917562;4050.797460126982;4324.956750432455;4846.8788280292565;4954.126606568182;5271.603025198249;4494.6629002825575;4530.501644819002;4801.9039619208115;5089.796408143781;5117.462666419972;4048.78925917043;4903.754812259302;4986.952739924656;5019.372578427697;5032.3961124665275;4827.176101980381;5184.948150518447;5187.92218116721;5189.766460509361;5207.29701490294;3479.7042251408916;3498.6676265754713;3504.8948531544092;3511.9297614047064;3549.391197469909;4546.863594092182;5017.899642007213;5037.697738135724;5090.676424129679;5688.5733569981585;4630.83792067276;5808.390119037609;5817;5882.794102206402;5928.8814223716145;4810.39870016248;5100.7610167543135;5878.118282257696;5908.911366329595;5933.910991335047;5376.838694839161;5739.598228124159;5782.537397008314;5791.797287094932;5822.737976791139;5858.602010833621;5899.587028908107;5945.316288626863;5978.611390259619;6025.78909738157;5174.654589806602;5272.2882410874045;5643.2472405851295;5763.308402991668;5895.528357731457 16:47:44 INFO - PROCESS | 1938 | |5;yui.html;679.7145199016412;687.972481100756;699.6431819771915;740.8259059121106;741.021851156473;15442.382304707813;15474.381024759025;15844.920775396107;15902.284397202126;16030.358785648574;11471.942640286787;14356.569302920903;14468.348924298405;14484.493042743507;14488.985770996034;847.1359213602107;879.9956000219989;882.3779235638859;885.4421714320001;892.6786356911507;666.9799906002828;882.4484697064335;889.5463313710022;896.5293221058931;898.7842917699737;868.2793281576309;909.4497828813571;927.939683920543;932.4172392254841;933.2394098809483;902.1700035966926;929.6885543342988;932.2495391210073;932.6549176804625;939.4832841936942;691.7060249393987;703.6130128429395;705.2806137739477;706.1455638677206;707.6072779607316;15396;15457.149856757875;15632;15651.452199172974;15705.607359815982;11394.71513212168;14430.422783088663;14503.56489305312;14520.782188267185;14652;10092.848607270897;11294.774104517863;11892.405379731066;12004.459799308965;12130.878691213064;3781.6785573226307;3849.326367885637;3867.9806600967095;3973.5033120859894;3990.940135897964;130515.34742326228;131400;133456;134048.32975835155;134466.327668362;10875.782484350428;11049.154163754696;11107.333559986426;11115.888841111648;11178;22786.8860655699;22849.428764281027;22866.771332286797;22889.656655150186;22956.540869182856;8046.356291496666;8071.313938315191;8089.312408445348;8152.470089444168;8168;4406.449193850769;4442.087840750851;4515.932261016087;4594.081183763261;4606.792694328763;3502.527158833525;3657.6159503252306;3664.670179683841;3669.376206044979;3674.577423596267;644.5005121031238;665.8634979829123;668.9230738465138;681.0329332348077;690.9654517274116;505.8229619633099;543.3859738495474;607.9878402431926;623.3859648246473;638.3329420755229;7994.520328780175;8126.959365203136;8558.844555984986;8814.206721394978;9486.430814151174;567.9062954612442;600.8227572866015;610.8961476548998;619.3280290884351;628.2241431831684;3914.001929508014;3935.8389275163895;4029.879103626896;4218.367244913287;4238.855509012549;124981;133063;154358;163791;163926;139687;143424.28287858493;147059;150974;154934;105077;110047.44976275068;119941;124564.37717811353;125277;7535.944967704635;7613.809654758454;8196.508209507449;8595.613197406257;8653.567321634018;51923.74038129785;58367;66831.66584167047;69068;70469.6476517614;63161.684191580585;70897;75785;82010.17989820025;82400;13181.143225690299;13278.933605331911;13386.933065335;13417.66455838612;13568.660783480493;14475.855241447873;14564.49024284145;15565.610859728597;15636.609084772972;16202;13384.732305354033;14132.717345652823;14727.92636036813;14759.557213283619;14784.48254311094;11635.767284654428;11752.941235293769;13811.930940345233;13816.516421925586;14462.987590868539;13241.801372979606;13283.601491955256;13283.66790830237;13479.595612131652;13482.19106853592;11034.779304414027;11037.668869933916;11246.66260012201;11571.942140289244;11834.52661893549;9752.46361450127;11343.489542970421;11418.942905285421;11426.314421134759;11496.94251528737 16:47:44 INFO - PROCESS | 1938 | __end_tp_report 16:47:44 INFO - PROCESS | 1938 | __start_cc_report 16:47:44 INFO - PROCESS | 1938 | _x_x_mozilla_cycle_collect,362 16:47:44 INFO - PROCESS | 1938 | __end_cc_report 16:47:44 INFO - PROCESS | 1938 | __startTimestamp1475624864945__endTimestamp 16:47:44 INFO - PROCESS | 1938 | 16:47:44 INFO - PROCESS | 1938 | ------- Summary: start ------- 16:47:44 INFO - PROCESS | 1938 | Number of tests: 6 16:47:44 INFO - PROCESS | 1938 | 16:47:44 INFO - PROCESS | 1938 | [#0] dojo.html Cycles:165 Average:5861.39 Median:6112.05 stddev:668.31 (10.9%) stddev-sans-first:633.09 16:47:44 INFO - PROCESS | 1938 | Values: 3056.3 3353.5 3452.4 3467.0 3501.9 4701.3 5937.0 5948.8 5962.8 5994.5 5796.7 5865.0 5914.4 5920.0 5935.2 5387.2 5397.6 5453.7 5456.7 5459.5 5448.9 5473.9 5474.9 5486.4 5526.3 5344.2 5394.7 5440.4 5456.8 5460.4 5299.9 5352.3 5397.9 5407.6 5409.9 5319.2 5345.2 5360.2 5431.3 5450.9 5758.9 6008.3 6032.5 6064.5 6093.0 6203.2 6261.5 6282.3 6331.7 6350.8 6351.9 6363.6 6371.0 6405.7 6411.4 5848.4 5884.4 5933.5 6003.5 6031.5 6025.3 6060.1 6385.5 6440.0 6491.2 4595.5 5581.9 6279.2 6309.8 6332.6 5145.4 6203.1 6338.7 6391.8 6457.5 6224.1 6275.5 6292.9 6306.9 6355.4 5470.9 5611.7 6272.4 6335.6 6371.5 4915.3 5046.0 5049.3 5049.4 5062.7 4409.0 4449.6 4464.5 4492.2 4554.7 5171.9 5978.9 6053.3 6064.7 6112.1 5764.3 6198.6 6225.8 6250.7 6313.7 6009.0 6029.1 6087.2 6113.7 6144.6 5510.6 5547.9 5564.1 5565.6 5584.9 6547.1 6555.3 6596.7 6603.0 6619.9 6185.9 6207.4 6216.4 6234.3 6235.2 6541.1 6558.7 6561.0 6561.5 6568.0 6253.7 6287.5 6328.4 6329.4 6364.9 6080.1 6219.5 6223.7 6236.5 6385.1 6307.9 6321.4 6327.3 6328.1 6341.8 6300.6 6302.6 6304.5 6311.2 6319.7 5822.6 6119.2 6134.7 6182.4 6238.3 6194.3 6248.8 6283.1 6319.1 6323.5 6140.1 6204.0 6211.4 6232.4 6236.8 16:47:44 INFO - PROCESS | 1938 | 16:47:44 INFO - PROCESS | 1938 | [#1] ext.html Cycles:180 Average:74658.58 Median:40243.80 stddev:173989.05 (432.3%) stddev-sans-first:174388.09 16:47:44 INFO - PROCESS | 1938 | Values: 517.2 523.9 531.9 542.3 573.7 38266.0 40631.4 40804.8 40824.8 40845.8 41241.0 41740.0 41781.8 41794.8 41839.0 9540.8 9741.3 9759.8 9776.1 9791.0 8808.9 9040.2 9786.5 9853.9 9894.1 9774.7 9864.0 9872.2 9874.9 9888.0 8241.8 9797.9 9845.4 9853.0 9856.9 9606.0 9672.4 9679.5 9700.2 9701.6 39596.0 39665.0 39789.2 39973.0 40864.6 2650.5 3175.5 3179.3 3209.2 3214.8 30567.7 30820.2 31099.1 31586.7 31834.4 3213.2 3264.6 3311.2 3312.6 3411.9 504470.0 517019.0 539160.0 539549.0 540466.0 32490.5 60687.0 60819.1 61043.8 61481.7 34489.5 35378.9 35588.3 35830.4 35857.6 15006.2 15141.4 15155.9 15163.8 15173.7 12741.0 12847.4 12853.6 12884.9 12901.9 7733.8 7737.7 7737.8 7783.7 7826.6 3253.1 3280.2 3289.4 3303.3 3308.1 894.8 917.4 937.9 973.6 1007.0 23368.8 30087.5 30475.0 30706.2 30875.0 933.5 941.0 1005.9 1034.6 1114.3 15338.7 15739.3 15895.8 15961.0 16255.5 752119.0 776470.0 777203.0 778794.0 782058.0 47184.0 57579.4 57910.1 58105.0 58342.4 1277.1 1309.1 1326.2 1331.4 1333.7 29156.6 29724.4 30093.0 30304.7 30598.8 51114.0 51294.2 51332.7 51421.7 51527.0 540806.0 542132.3 658859.0 659778.0 661277.0 20224.4 22100.8 23160.3 24716.6 26939.3 46980.5 47744.0 48062.0 48300.8 48345.0 38609.6 39480.4 39771.6 39841.0 40906.6 38601.8 39626.4 40514.6 40646.6 41159.8 37437.0 38095.6 38298.4 38442.6 39018.4 33691.0 34399.5 34833.8 35095.6 35394.0 25687.9 26013.6 26066.5 26484.9 26756.9 16:47:44 INFO - PROCESS | 1938 | 16:47:44 INFO - PROCESS | 1938 | [#2] jquery.html Cycles:180 Average:35458.35 Median:398.75 stddev:102435.93 (25689.5%) stddev-sans-first:102689.31 16:47:44 INFO - PROCESS | 1938 | Values: 320.6 380.8 382.9 390.7 406.8 19441.3 20193.5 20197.0 20542.4 20798.1 19761.8 19897.0 20238.3 20496.5 20797.6 5351.8 5812.1 5975.5 6020.2 6024.4 6002.2 6016.8 6082.6 6098.5 6113.6 6027.8 6308.0 6645.5 6678.0 6773.6 6050.2 6183.8 6674.9 6699.0 6717.7 5888.1 5910.9 5917.1 5923.7 5924.3 11990.2 12174.8 12259.7 12314.9 12328.3 1986.4 2090.7 2111.2 2153.3 2199.9 9953.9 10005.0 10131.5 10284.7 10434.8 1905.9 1970.5 1975.3 1989.8 1998.9 76435.0 122997.0 125704.0 134621.0 135821.3 11417.8 11656.1 11670.9 11817.6 11916.8 11898.0 11960.4 14600.6 14736.5 14753.6 8511.2 8712.9 8726.6 8845.8 8850.0 8695.2 8737.4 8737.7 8881.9 8888.2 4491.4 4516.2 4563.3 4574.0 4611.1 1921.3 1971.4 1973.2 1982.4 2038.6 802.3 878.2 953.0 959.7 975.0 15752.8 20416.4 20533.3 20747.9 21631.9 738.5 799.3 881.7 933.5 943.7 8445.6 8471.8 8755.9 9120.8 11338.2 535180.0 620782.0 626202.0 626343.0 640939.0 128192.0 128737.0 136596.0 149353.3 159867.2 932.6 953.2 960.5 969.1 972.2 16242.7 19028.9 19631.2 19820.0 19832.4 56481.4 57219.0 58074.0 58281.1 58610.4 59440.7 79059.0 81119.0 84496.3 86546.0 8007.3 8047.1 8288.5 8356.0 8431.6 10907.3 13258.8 13446.5 13547.9 13688.3 11443.4 11487.8 11536.6 11674.9 11764.8 11047.0 11415.9 11500.8 11578.2 11722.3 5842.9 8227.6 10109.7 11621.3 11965.7 7659.6 8016.6 8342.7 8386.3 8654.4 10315.7 10721.9 11038.3 11456.7 11491.0 16:47:44 INFO - PROCESS | 1938 | 16:47:44 INFO - PROCESS | 1938 | [#3] mootools.html Cycles:180 Average:5741.42 Median:2487.06 stddev:3275.21 (131.7%) stddev-sans-first:3268.90 16:47:44 INFO - PROCESS | 1938 | Values: 1502.0 1536.4 1584.9 1700.4 1843.2 8130.9 8373.5 8588.5 9181.1 9182.2 8581.6 8882.4 8895.0 8972.7 8999.7 2374.8 2421.3 2425.3 2426.7 2431.6 2373.5 2405.2 2409.5 2410.5 2412.4 2417.9 2420.1 2422.4 2426.3 2434.4 2105.3 2379.9 2395.1 2404.0 2409.2 2384.5 2396.1 2411.1 2412.9 2414.9 8033.0 8531.4 8971.2 9051.3 9068.7 5278.4 5427.7 5434.7 5444.2 5451.2 3116.5 3663.0 3676.1 3742.7 3743.0 1025.2 1052.2 1084.1 1102.9 1107.0 11856.6 11876.5 11900.6 11985.7 12058.7 3894.3 4306.4 4768.5 4806.7 4961.9 8959.5 10011.2 10132.8 10133.6 10138.5 5401.8 5406.1 5412.2 5419.0 5424.8 4462.9 4583.0 4748.4 4817.1 4936.4 3409.4 3996.9 4104.8 4126.7 4141.2 1320.9 1323.1 1331.9 1339.2 1342.1 791.8 798.9 920.9 933.5 939.9 5027.2 5851.9 5855.4 6036.8 6067.2 432.9 438.6 452.2 454.6 457.3 3939.4 3973.3 3987.0 4038.5 4123.7 10646.8 10933.4 10948.7 10958.8 11084.4 10897.5 10949.4 10965.3 10990.2 11005.7 8245.7 8267.2 8317.4 8343.4 8348.6 4522.0 5048.4 5911.1 6085.6 6159.6 9958.4 10132.9 10175.5 10237.9 10340.4 9718.0 10033.6 10350.9 10395.8 10508.9 7618.0 7619.9 7665.8 7696.2 7723.2 8337.5 8343.3 8419.0 8419.6 8423.2 7468.2 7532.7 7597.5 7681.9 7734.0 5917.9 7384.7 7464.6 7603.2 7632.2 7024.9 7064.3 7090.9 7123.4 7131.5 4329.9 4482.0 5041.8 5102.0 5151.4 4439.1 4964.7 5088.9 5153.8 5258.3 16:47:44 INFO - PROCESS | 1938 | 16:47:44 INFO - PROCESS | 1938 | [#4] prototype.html Cycles:180 Average:4396.11 Median:4758.93 stddev:1366.16 (28.7%) stddev-sans-first:1334.44 16:47:44 INFO - PROCESS | 1938 | Values: 270.6 300.9 305.5 311.1 323.4 5266.8 5353.4 5444.4 5612.9 5705.9 4977.0 5268.9 5427.3 5462.2 5496.8 3632.9 3868.9 3984.0 4159.7 4163.3 3915.8 4090.4 4150.0 4283.1 4293.8 3587.9 4092.2 4105.2 4124.3 4151.4 4134.0 4151.9 4181.5 4202.5 4214.4 3209.6 3256.0 3566.8 3600.4 3603.8 4514.4 4758.9 5057.7 5333.7 5434.3 4164.4 4194.4 4745.7 4755.7 4781.5 5821.9 5822.6 5839.6 5843.5 5849.7 3565.9 3669.8 3896.7 3902.9 3907.0 6075.0 6095.2 6098.8 6122.9 6153.4 3985.2 3992.0 3999.1 3999.2 4033.0 3754.9 3841.7 4042.8 4055.5 4061.5 4716.9 4729.7 4749.3 4769.7 4786.2 4759.0 4833.0 4896.4 5926.7 5991.6 1151.8 1176.4 1303.9 1304.2 1359.6 817.0 832.1 848.8 850.6 853.5 3994.2 4191.8 4257.6 4547.7 4606.5 4598.2 5009.3 5058.6 5069.5 5121.9 3825.1 4161.8 4459.4 4634.7 4664.6 2261.5 2265.6 2494.2 2643.7 2657.9 4833.4 4908.2 5180.7 5203.2 5311.9 4152.8 4419.1 4425.0 4704.6 4890.5 4050.8 4325.0 4846.9 4954.1 5271.6 4494.7 4530.5 4801.9 5089.8 5117.5 4048.8 4903.8 4987.0 5019.4 5032.4 4827.2 5184.9 5187.9 5189.8 5207.3 3479.7 3498.7 3504.9 3511.9 3549.4 4546.9 5017.9 5037.7 5090.7 5688.6 4630.8 5808.4 5817.0 5882.8 5928.9 4810.4 5100.8 5878.1 5908.9 5933.9 5376.8 5739.6 5782.5 5791.8 5822.7 5858.6 5899.6 5945.3 5978.6 6025.8 5174.7 5272.3 5643.2 5763.3 5895.5 16:47:44 INFO - PROCESS | 1938 | 16:47:44 INFO - PROCESS | 1938 | [#5] yui.html Cycles:180 Average:25758.97 Median:3661.14 stddev:42359.96 (1157.0%) stddev-sans-first:42436.94 16:47:44 INFO - PROCESS | 1938 | Values: 679.7 688.0 699.6 740.8 741.0 15442.4 15474.4 15844.9 15902.3 16030.4 11471.9 14356.6 14468.3 14484.5 14489.0 847.1 880.0 882.4 885.4 892.7 667.0 882.4 889.5 896.5 898.8 868.3 909.4 927.9 932.4 933.2 902.2 929.7 932.2 932.7 939.5 691.7 703.6 705.3 706.1 707.6 15396.0 15457.1 15632.0 15651.5 15705.6 11394.7 14430.4 14503.6 14520.8 14652.0 10092.8 11294.8 11892.4 12004.5 12130.9 3781.7 3849.3 3868.0 3973.5 3990.9 130515.3 131400.0 133456.0 134048.3 134466.3 10875.8 11049.2 11107.3 11115.9 11178.0 22786.9 22849.4 22866.8 22889.7 22956.5 8046.4 8071.3 8089.3 8152.5 8168.0 4406.4 4442.1 4515.9 4594.1 4606.8 3502.5 3657.6 3664.7 3669.4 3674.6 644.5 665.9 668.9 681.0 691.0 505.8 543.4 608.0 623.4 638.3 7994.5 8127.0 8558.8 8814.2 9486.4 567.9 600.8 610.9 619.3 628.2 3914.0 3935.8 4029.9 4218.4 4238.9 124981.0 133063.0 154358.0 163791.0 163926.0 139687.0 143424.3 147059.0 150974.0 154934.0 105077.0 110047.4 119941.0 124564.4 125277.0 7535.9 7613.8 8196.5 8595.6 8653.6 51923.7 58367.0 66831.7 69068.0 70469.6 63161.7 70897.0 75785.0 82010.2 82400.0 13181.1 13278.9 13386.9 13417.7 13568.7 14475.9 14564.5 15565.6 15636.6 16202.0 13384.7 14132.7 14727.9 14759.6 14784.5 11635.8 11752.9 13811.9 13816.5 14463.0 13241.8 13283.6 13283.7 13479.6 13482.2 11034.8 11037.7 11246.7 11571.9 11834.5 9752.5 11343.5 11418.9 11426.3 11496.9 16:47:44 INFO - PROCESS | 1938 | -------- Summary: end -------- 16:47:44 INFO - PROCESS | 1938 | 16:47:45 INFO - TEST-INFO | 1938: exit 0 16:47:45 INFO - TEST-OK | dromaeo_css | took 1113593ms 16:47:45 INFO - TEST-START | kraken 16:47:45 INFO - operating with platform_type : mac_ 16:47:45 INFO - Initialising browser for kraken test... 16:47:45 INFO - TEST-INFO | started process 1947 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/tmp9zlzxV/profile http://localhost:49462/getInfo.html) 16:47:48 INFO - PROCESS | 1947 | __metrics Screen width/height:1600/1200 16:47:48 INFO - PROCESS | 1947 | colorDepth:24 16:47:48 INFO - PROCESS | 1947 | Browser inner width/height: 1024/689 16:47:48 INFO - PROCESS | 1947 | __metrics 16:47:48 ERROR - PROCESS | 1947 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 16:47:48 INFO - TEST-INFO | 1947: exit 0 16:47:48 INFO - Browser initialized. 16:47:48 INFO - Running cycle 1/1 for kraken test... 16:47:48 INFO - TEST-INFO | started process 1949 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/tmp9zlzxV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:48:00 INFO - PROCESS | 1949 | RSS: Main: 225370112 16:48:00 INFO - PROCESS | 1949 | 16:48:03 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:49462/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49462/tests/kraken/driver.html?testName=audio-beat-detection) 16:48:04 INFO - PROCESS | 1949 | RSS: Main: 237670400 16:48:04 INFO - PROCESS | 1949 | 16:48:07 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:49462/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49462/tests/kraken/driver.html?testName=audio-dft) 16:48:08 INFO - PROCESS | 1949 | RSS: Main: 245116928 16:48:08 INFO - PROCESS | 1949 | 16:48:11 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:49462/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49462/tests/kraken/driver.html?testName=audio-fft) 16:48:12 INFO - PROCESS | 1949 | RSS: Main: 246890496 16:48:12 INFO - PROCESS | 1949 | 16:48:14 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:49462/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49462/tests/kraken/driver.html?testName=audio-oscillator) 16:48:15 INFO - PROCESS | 1949 | RSS: Main: 249634816 16:48:15 INFO - PROCESS | 1949 | 16:48:17 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:49462/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49462/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:48:17 INFO - PROCESS | 1949 | RSS: Main: 250257408 16:48:17 INFO - PROCESS | 1949 | 16:48:20 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:49462/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49462/tests/kraken/driver.html?testName=imaging-darkroom) 16:48:21 INFO - PROCESS | 1949 | RSS: Main: 250892288 16:48:21 INFO - PROCESS | 1949 | 16:48:24 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:49462/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49462/tests/kraken/driver.html?testName=imaging-desaturate) 16:48:24 INFO - PROCESS | 1949 | RSS: Main: 251236352 16:48:24 INFO - PROCESS | 1949 | 16:48:27 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:49462/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49462/tests/kraken/driver.html?testName=json-parse-financial) 16:48:28 INFO - PROCESS | 1949 | RSS: Main: 251351040 16:48:28 INFO - PROCESS | 1949 | 16:48:30 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:49462/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49462/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:48:30 INFO - PROCESS | 1949 | RSS: Main: 250753024 16:48:30 INFO - PROCESS | 1949 | 16:48:32 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:49462/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49462/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:48:33 INFO - PROCESS | 1949 | RSS: Main: 250789888 16:48:33 INFO - PROCESS | 1949 | 16:48:35 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:49462/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49462/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:48:36 INFO - PROCESS | 1949 | RSS: Main: 251392000 16:48:36 INFO - PROCESS | 1949 | 16:48:39 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:49462/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49462/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:48:39 INFO - PROCESS | 1949 | RSS: Main: 251203584 16:48:39 INFO - PROCESS | 1949 | 16:48:42 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:49462/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49462/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:48:43 INFO - PROCESS | 1949 | RSS: Main: 251060224 16:48:43 INFO - PROCESS | 1949 | 16:48:45 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:49462/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49462/tests/kraken/driver.html?testName=ai-astar) 16:48:45 INFO - PROCESS | 1949 | RSS: Main: 252481536 16:48:45 INFO - PROCESS | 1949 | 16:48:45 INFO - PROCESS | 1949 | __start_tp_report 16:48:45 INFO - PROCESS | 1949 | _x_x_mozilla_page_load 16:48:45 INFO - PROCESS | 1949 | _x_x_mozilla_page_load_details 16:48:45 INFO - PROCESS | 1949 | |i|pagename|runs| 16:48:45 INFO - PROCESS | 1949 | |0;ai-astar;106;119;119;119;121;122;139;117;120;119 16:48:45 INFO - PROCESS | 1949 | |1;audio-beat-detection;124;121;98;163;141;141;112;144;171;95 16:48:45 INFO - PROCESS | 1949 | |2;audio-dft;273;277;196;254;211;199;275;210;277;274 16:48:45 INFO - PROCESS | 1949 | |3;audio-fft;89;58;56;103;60;52;71;84;68;69 16:48:45 INFO - PROCESS | 1949 | |4;audio-oscillator;88;71;114;105;92;69;88;73;87;112 16:48:45 INFO - PROCESS | 1949 | |5;imaging-gaussian-blur;88;87;88;85;106;110;88;89;89;109 16:48:45 INFO - PROCESS | 1949 | |6;imaging-darkroom;98;100;98;100;108;171;122;105;97;110 16:48:45 INFO - PROCESS | 1949 | |7;imaging-desaturate;102;95;91;151;120;90;129;146;104;150 16:48:45 INFO - PROCESS | 1949 | |8;json-parse-financial;53;51;53;52;58;57;59;64;77;82 16:48:45 INFO - PROCESS | 1949 | |9;json-stringify-tinderbox;70;71;70;78;71;71;81;94;71;70 16:48:45 INFO - PROCESS | 1949 | |10;stanford-crypto-aes;76;97;109;106;77;85;74;86;91;73 16:48:45 INFO - PROCESS | 1949 | |11;stanford-crypto-ccm;139;159;136;132;159;161;141;145;167;166 16:48:45 INFO - PROCESS | 1949 | |12;stanford-crypto-pbkdf2;166;149;204;232;220;167;160;163;162;164 16:48:45 INFO - PROCESS | 1949 | |13;stanford-crypto-sha256-iterative;69;68;64;67;68;65;68;67;67;65 16:48:45 INFO - PROCESS | 1949 | __end_tp_report 16:48:45 INFO - PROCESS | 1949 | __start_cc_report 16:48:45 INFO - PROCESS | 1949 | _x_x_mozilla_cycle_collect,926 16:48:45 INFO - PROCESS | 1949 | __end_cc_report 16:48:45 INFO - PROCESS | 1949 | __startTimestamp1475624925398__endTimestamp 16:48:45 INFO - PROCESS | 1949 | 16:48:45 INFO - PROCESS | 1949 | ------- Summary: start ------- 16:48:45 INFO - PROCESS | 1949 | Number of tests: 14 16:48:45 INFO - PROCESS | 1949 | 16:48:45 INFO - PROCESS | 1949 | [#0] ai-astar Cycles:10 Average:120.10 Median:119.50 stddev:7.99 (6.7%) stddev-sans-first:6.65 16:48:45 INFO - PROCESS | 1949 | Values: 106.0 119.0 119.0 119.0 121.0 122.0 139.0 117.0 120.0 119.0 16:48:45 INFO - PROCESS | 1949 | 16:48:45 INFO - PROCESS | 1949 | [#1] audio-beat-detection Cycles:10 Average:131.00 Median:153.50 stddev:25.58 (16.7%) stddev-sans-first:27.00 16:48:45 INFO - PROCESS | 1949 | Values: 124.0 121.0 98.0 163.0 141.0 141.0 112.0 144.0 171.0 95.0 16:48:45 INFO - PROCESS | 1949 | 16:48:45 INFO - PROCESS | 1949 | [#2] audio-dft Cycles:10 Average:244.60 Median:273.50 stddev:35.82 (13.1%) stddev-sans-first:36.49 16:48:45 INFO - PROCESS | 1949 | Values: 273.0 277.0 196.0 254.0 211.0 199.0 275.0 210.0 277.0 274.0 16:48:45 INFO - PROCESS | 1949 | 16:48:45 INFO - PROCESS | 1949 | [#3] audio-fft Cycles:10 Average:71.00 Median:68.50 stddev:16.35 (23.9%) stddev-sans-first:15.99 16:48:45 INFO - PROCESS | 1949 | Values: 89.0 58.0 56.0 103.0 60.0 52.0 71.0 84.0 68.0 69.0 16:48:45 INFO - PROCESS | 1949 | 16:48:45 INFO - PROCESS | 1949 | [#4] audio-oscillator Cycles:10 Average:89.90 Median:80.00 stddev:16.32 (20.4%) stddev-sans-first:17.29 16:48:45 INFO - PROCESS | 1949 | Values: 88.0 71.0 114.0 105.0 92.0 69.0 88.0 73.0 87.0 112.0 16:48:45 INFO - PROCESS | 1949 | 16:48:45 INFO - PROCESS | 1949 | [#5] imaging-gaussian-blur Cycles:10 Average:93.90 Median:88.00 stddev:10.07 (11.4%) stddev-sans-first:10.45 16:48:45 INFO - PROCESS | 1949 | Values: 88.0 87.0 88.0 85.0 106.0 110.0 88.0 89.0 89.0 109.0 16:48:45 INFO - PROCESS | 1949 | 16:48:45 INFO - PROCESS | 1949 | [#6] imaging-darkroom Cycles:10 Average:110.90 Median:146.50 stddev:22.47 (15.3%) stddev-sans-first:23.34 16:48:45 INFO - PROCESS | 1949 | Values: 98.0 100.0 98.0 100.0 108.0 171.0 122.0 105.0 97.0 110.0 16:48:45 INFO - PROCESS | 1949 | 16:48:45 INFO - PROCESS | 1949 | [#7] imaging-desaturate Cycles:10 Average:117.80 Median:150.50 stddev:24.76 (16.4%) stddev-sans-first:25.59 16:48:45 INFO - PROCESS | 1949 | Values: 102.0 95.0 91.0 151.0 120.0 90.0 129.0 146.0 104.0 150.0 16:48:45 INFO - PROCESS | 1949 | 16:48:45 INFO - PROCESS | 1949 | [#8] json-parse-financial Cycles:10 Average:60.60 Median:58.50 stddev:10.76 (18.4%) stddev-sans-first:11.06 16:48:45 INFO - PROCESS | 1949 | Values: 53.0 51.0 53.0 52.0 58.0 57.0 59.0 64.0 77.0 82.0 16:48:45 INFO - PROCESS | 1949 | 16:48:45 INFO - PROCESS | 1949 | [#9] json-stringify-tinderbox Cycles:10 Average:74.70 Median:71.00 stddev:7.78 (11.0%) stddev-sans-first:8.06 16:48:45 INFO - PROCESS | 1949 | Values: 70.0 71.0 70.0 78.0 71.0 71.0 81.0 94.0 71.0 70.0 16:48:45 INFO - PROCESS | 1949 | 16:48:45 INFO - PROCESS | 1949 | [#10] stanford-crypto-aes Cycles:10 Average:87.40 Median:81.00 stddev:13.13 (16.2%) stddev-sans-first:13.26 16:48:45 INFO - PROCESS | 1949 | Values: 76.0 97.0 109.0 106.0 77.0 85.0 74.0 86.0 91.0 73.0 16:48:45 INFO - PROCESS | 1949 | 16:48:45 INFO - PROCESS | 1949 | [#11] stanford-crypto-ccm Cycles:10 Average:150.50 Median:159.00 stddev:13.22 (8.3%) stddev-sans-first:13.35 16:48:45 INFO - PROCESS | 1949 | Values: 139.0 159.0 136.0 132.0 159.0 161.0 141.0 145.0 167.0 166.0 16:48:45 INFO - PROCESS | 1949 | 16:48:45 INFO - PROCESS | 1949 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.70 Median:166.50 stddev:28.79 (17.3%) stddev-sans-first:30.16 16:48:45 INFO - PROCESS | 1949 | Values: 166.0 149.0 204.0 232.0 220.0 167.0 160.0 163.0 162.0 164.0 16:48:45 INFO - PROCESS | 1949 | 16:48:45 INFO - PROCESS | 1949 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.50 stddev:1.62 (2.4%) stddev-sans-first:1.51 16:48:45 INFO - PROCESS | 1949 | Values: 69.0 68.0 64.0 67.0 68.0 65.0 68.0 67.0 67.0 65.0 16:48:45 INFO - PROCESS | 1949 | -------- Summary: end -------- 16:48:45 INFO - PROCESS | 1949 | 16:48:46 INFO - TEST-INFO | 1949: exit 0 16:48:46 INFO - TEST-OK | kraken | took 60574ms 16:48:46 INFO - SUITE-END | took 1174s 16:48:46 INFO - Completed test suite (00:19:34) 16:48:46 INFO - javascript benchmark 16:48:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7245.141060605876, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3056.327607926258, 3353.547271118399, 3452.4476083826576, 3466.9653303466976, 3501.859925602976, 4701.341812146302, 5937.0, 5948.791792287271, 5962.791302304426, 5994.490468310188, 5796.652200867951, 5865.002949498585, 5914.4085591440835, 5920.023196172627, 5935.198748168996, 5387.19192121183, 5397.649152805075, 5453.672779633215, 5456.727163641822, 5459.508644222019, 5448.91826622601, 5473.945260547403, 5474.945250547503, 5486.396496385394, 5526.309211348582, 5344.171653393731, 5394.703291318995, 5440.401555828876, 5456.8090116845915, 5460.399356070829, 5299.920501192485, 5352.277442545265, 5397.919031214535, 5407.594430417735, 5409.918851217235, 5319.17552779316, 5345.198220266952, 5360.16917377807, 5431.348238211401, 5450.937067271883, 5758.88482230353, 6008.309044459899, 6032.547558933097, 6064.54515911304, 6093.0, 6203.162573052626, 6261.499080073629, 6282.277538083134, 6331.651759153245, 6350.809475715736, 6351.9364806351805, 6363.61818290904, 6371.0, 6405.711742971577, 6411.4229719325485, 5848.356680765112, 5884.352721200665, 5933.465988061095, 6003.549733769941, 6031.45716885478, 6025.307089684655, 6060.121282414026, 6385.48916086712, 6440.0, 6491.188601424822, 4595.494495605481, 5581.916271255935, 6279.152314437584, 6309.779157729457, 6332.6200427973545, 5145.3568303962, 6203.131561581382, 6338.714757835908, 6391.840203994937, 6457.5479716419395, 6224.128621992924, 6275.529335299871, 6292.867283888944, 6306.905396419057, 6355.396237357444, 5470.863228419322, 5611.663300202001, 6272.40412160844, 6335.588186767845, 6371.52213583983, 4915.26271059344, 5046.041252162077, 5049.343585333883, 5049.394072711299, 5062.7215503146945, 4408.955910440919, 4449.555044495589, 4464.531224221475, 4492.191405547033, 4554.726716396961, 5171.922421163686, 5978.940210597925, 6053.303870054912, 6064.696765161724, 6112.052631842072, 5764.250647415893, 6198.566100372931, 6225.84821807967, 6250.6874656267, 6313.652749098752, 6009.038553831366, 6029.125776762433, 6087.208662873798, 6113.719560719409, 6144.600600960924, 5510.614257001971, 5547.945890280834, 5564.137558678412, 5565.610407271533, 5584.91622625661, 6547.148870646785, 6555.311692272434, 6596.67016649156, 6603.0, 6619.86760264792, 6185.907211391743, 6207.410296021871, 6216.44052035319, 6234.345393733593, 6235.220597425322, 6541.149650545399, 6558.672066396565, 6561.0, 6561.475081993524, 6568.047633093079, 6253.687315634291, 6287.46556542699, 6328.398802113792, 6329.430351268408, 6364.872702546016, 6080.118382834376, 6219.47134493555, 6223.688815559294, 6236.532260080603, 6385.074164246251, 6307.90538141919, 6321.367863213642, 6327.303996560467, 6328.145700330397, 6341.841453963688, 6300.621962682254, 6302.621842689453, 6304.527160463075, 6311.179546658905, 6319.715612797343, 5822.592418530662, 6119.204503414528, 6134.693265336626, 6182.412670796267, 6238.313785483502, 6194.256689197326, 6248.843778905563, 6283.120363149254, 6319.146915166578, 6323.462505687068, 6140.078988151813, 6204.038374052029, 6211.409916057967, 6232.376762323732, 6236.812895613139], "value": 5819.6653195472145, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [517.1776874769117, 523.8768889311011, 531.9255304257405, 542.3356388424179, 573.7332140554641, 38266.0, 40631.39052914205, 40804.795976020076, 40824.79587602065, 40845.79577102114, 41241.0, 41740.0, 41781.79109104458, 41794.791026044906, 41839.0, 9540.80918381632, 9741.31810773246, 9759.804803903917, 9776.071273229032, 9791.020897910223, 8808.911910880874, 9040.231580315649, 9786.510674466284, 9853.852192217122, 9894.060064293917, 9774.706758797212, 9864.0, 9872.16086632637, 9874.851877221847, 9888.0, 8241.793955151139, 9797.853032204523, 9845.409275443424, 9852.95073524635, 9856.90143098567, 9606.0, 9672.371295865747, 9679.467629280387, 9700.223982081416, 9701.611935522642, 39596.0, 39665.0, 39789.20421591552, 39973.0, 40864.59135408638, 2650.509655713699, 3175.539546765706, 3179.332340208559, 3209.1977005748563, 3214.758893083028, 30567.69432305693, 30820.2294942626, 31099.06702798897, 31586.684133158604, 31834.363312733847, 3213.2127628730877, 3264.5919260092487, 3311.1556553079054, 3312.6190488093935, 3411.8805841795665, 504470.0, 517019.0, 539160.0, 539549.0, 540466.0, 32490.512642310383, 60687.0, 60819.087713684334, 61043.77912441726, 61481.69259153765, 34489.482657760156, 35378.93863184108, 35588.28823423569, 35830.387632556594, 35857.64142358543, 15006.249687515581, 15141.394344226108, 15155.924220378827, 15163.848361516464, 15173.696526069416, 12741.044421668412, 12847.394075740533, 12853.614391568268, 12884.871151288555, 12901.870981290254, 7733.845323093619, 7737.690492380354, 7737.806554836174, 7783.727569535153, 7826.569538675313, 3253.121657152603, 3280.155061875643, 3289.4079065767914, 3303.339332133583, 3308.073739352937, 894.7718331825342, 917.4082716647724, 937.9108984646448, 973.634886917406, 1006.9678579456116, 23368.76631233666, 30087.548686769715, 30475.0, 30706.232344191572, 30875.0, 933.5425641435784, 940.9978373032699, 1005.949702514886, 1034.5809946971488, 1114.2534501883758, 15338.693226135638, 15739.291731872094, 15895.761563576556, 15961.0, 16255.51233462998, 752119.0, 776470.0, 777203.0, 778794.0, 782058.0, 47184.0, 57579.424205758245, 57910.13134802981, 58105.0, 58342.41657583455, 1277.131550545638, 1309.0967232609469, 1326.1777697827408, 1331.4141777617817, 1333.686583652841, 29156.562651560667, 29724.405511890072, 30093.0, 30304.696953030187, 30598.776048957792, 51114.0, 51294.230586540485, 51332.74333628308, 51421.74289128531, 51527.0, 540806.0, 542132.2893385508, 658859.0, 659778.0, 661277.0, 20224.393268201977, 22100.77899220987, 23160.3051908443, 24716.629250560898, 26939.326516837235, 46980.53019469762, 47744.0, 48062.03875922392, 48300.758496207294, 48345.0, 38609.613903861726, 39480.40779388369, 39771.60228397795, 39841.0, 40906.59093409028, 38601.8419447417, 39626.40560391539, 40514.59485405226, 40646.59353406546, 41159.7942010288, 37437.0, 38095.619043810315, 38298.425523616614, 38442.615573845025, 39018.41472377974, 33691.0, 34399.484007739404, 34833.825830870686, 35095.649043509235, 35394.0, 25687.871560642077, 26013.609795853456, 26066.478670426866, 26484.867575662, 26756.92972281165], "value": 18786.327305943258, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.64728798321846, 380.83624041662074, 382.8698242597518, 390.6835463274746, 406.8080524064492, 19441.319553815618, 20193.49516262094, 20197.0, 20542.38372848813, 20798.06408711608, 19761.802381976177, 19897.00514974249, 20238.29165979191, 20496.487587810312, 20797.584048319062, 5351.849352389236, 5812.070068788995, 5975.52195824333, 6020.187274717922, 6024.397560243984, 6002.189704389917, 6016.789412370568, 6082.635041897501, 6098.481629061535, 6113.602615829979, 6027.789027384042, 6307.990721484563, 6645.501587380942, 6678.031685405614, 6773.559718618274, 6050.2437195350585, 6183.81448556544, 6674.93325066748, 6698.961660942562, 6717.6977036033495, 5888.146218798293, 5910.881782364371, 5917.14201440793, 5923.674197919113, 5924.259467566554, 11990.220635658741, 12174.756504869942, 12259.69350766229, 12314.891659750576, 12328.32194229317, 1986.4437957371958, 2090.6654935210295, 2111.2399536166968, 2153.321703663341, 2199.8570092943905, 9953.850692239623, 10005.0, 10131.493425328777, 10284.691459256233, 10434.79130417395, 1905.8856468611928, 1970.4581240158927, 1975.338261682338, 1989.7512810898638, 1998.860079794415, 76435.0, 122997.0, 125704.0, 134621.0, 135821.3208933949, 11417.828732569018, 11656.067514598812, 11670.94164529172, 11817.64097128824, 11916.821247681291, 11898.0, 11960.40197990097, 14600.634984125269, 14736.48422305214, 14753.631159221106, 8511.233988941025, 8712.91287087121, 8726.607302671395, 8845.823083538293, 8850.0, 8695.173958473935, 8737.43206691563, 8737.694180703773, 8881.911180888237, 8888.24449921751, 4491.393661855673, 4516.23224051912, 4563.269876819693, 4573.977130114395, 4611.1469378164475, 1921.2795201799324, 1971.39872338938, 1973.190991693399, 1982.415187519685, 2038.5718999010078, 802.334062727946, 878.2052242720348, 953.0421925964362, 959.7456673981261, 974.9951250243845, 15752.76370854438, 20416.387508374773, 20533.2813351532, 20747.896260518904, 21631.89184054101, 738.4683028219673, 799.3325573146487, 881.7487016200353, 933.5239028095721, 943.7451887990204, 8445.57772111392, 8471.830563388698, 8755.868661970075, 9120.771980700536, 11338.206325557132, 535180.0, 620782.0, 626202.0, 626343.0, 640939.0, 128192.0, 128737.0, 136596.0, 149353.25323373312, 159867.20066399826, 932.5570354081892, 953.1516949914582, 960.490939801906, 969.0890562870878, 972.2027937091517, 16242.675146496767, 19028.858268503933, 19631.214751409785, 19820.0, 19832.40502784919, 56481.43518564762, 57219.0, 58074.0, 58281.12578311244, 58610.413895860496, 59440.70279648574, 79059.0, 81119.0, 84496.31007379941, 86546.0, 8007.263994601455, 8047.114817370201, 8288.461250018729, 8355.95822020886, 8431.620577074169, 10907.345559266469, 13258.801117983045, 13446.46214151423, 13547.86452135466, 13688.315584220949, 11443.370614616277, 11487.770244595229, 11536.59621913229, 11674.94162529182, 11764.82352764692, 11047.0, 11415.885841141482, 11500.82748758786, 11578.189526733047, 11722.296662200295, 5842.919059973919, 8227.588620569068, 10109.73628296463, 11621.28403697227, 11965.700857478632, 7659.578723170279, 8016.559089250147, 8342.666293348198, 8386.28716559075, 8654.437461564978, 10315.658964334589, 10721.892781072402, 11038.337699738042, 11456.713582160513, 11490.965813076864], "value": 9411.142729268846, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1502.0462006625792, 1536.431520337475, 1584.8652864506516, 1700.3793615330408, 1843.216632931004, 8130.878036829452, 8373.497590144596, 8588.527630980294, 9181.081891810823, 9182.173604375605, 8581.613827377767, 8882.378233523656, 8894.977077636075, 8972.685955991541, 8999.685011024616, 2374.7506511816227, 2421.3462365161395, 2425.2845410603827, 2426.720927093389, 2431.57447446697, 2373.537160253751, 2405.1822380390663, 2409.4819613783034, 2410.505846301504, 2412.384841865322, 2417.867017314047, 2420.1166574200465, 2422.39440139965, 2426.3085020769086, 2434.42790944128, 2105.263157894732, 2379.8691071991034, 2395.125779090628, 2404.014354114822, 2409.229046705055, 2384.511175209078, 2396.0535588442467, 2411.0837881605053, 2412.9034838606435, 2414.9275521734376, 8032.9557157569725, 8531.360147988864, 8971.237444817198, 9051.27589792815, 9068.68259610917, 5278.392984806758, 5427.728613569306, 5434.701091439969, 5444.210589464506, 5451.209574611659, 3116.4702000659718, 3663.010987033486, 3676.099355657881, 3742.6631603155847, 3743.026813028605, 1025.220832167558, 1052.1898138433364, 1084.1218612923558, 1102.85662863828, 1107.0036966729926, 11856.585019524362, 11876.524939002516, 11900.583479578174, 11985.700357491045, 12058.69853253667, 3894.279558281727, 4306.41863348444, 4768.499307572724, 4806.711597304173, 4961.90076198474, 8959.462432254086, 10011.199104071657, 10132.797344053077, 10133.594656213816, 10138.543765530569, 5401.838604700009, 5406.08096623575, 5412.161115027177, 5418.972905135449, 5424.755885985141, 4462.933056004163, 4582.95417045832, 4748.382710247714, 4817.108834865561, 4936.3829521309835, 3409.403354412968, 3996.86010989614, 4104.753714777123, 4126.66986641068, 4141.233871733739, 1320.940557674907, 1323.133347657286, 1331.9267440290878, 1339.1830983100301, 1342.1477361875084, 791.8139237279235, 798.8641930871765, 920.889493260813, 933.4632586262791, 939.8637197606308, 5027.245913113063, 5851.941480585139, 5855.414458554195, 6036.849078773066, 6067.211262535842, 432.86148432501926, 438.5723919178775, 452.15221459762944, 454.64991956194206, 457.2957645226381, 3939.38485221058, 3973.324534829086, 3986.980065099656, 4038.495188101487, 4123.670106391542, 10646.787064258671, 10933.398663073449, 10948.671539853816, 10958.780824383468, 11084.445777711244, 10897.509612067475, 10949.397783122005, 10965.342079475256, 10990.230683852054, 11005.669829905115, 8245.670173193124, 8267.173282671685, 8317.376196785144, 8343.415960882801, 8348.582570871433, 4521.977390113028, 5048.368953880765, 5911.083782013795, 6085.574009819447, 6159.599626024294, 9958.402495850272, 10132.89867101349, 10175.491225438847, 10237.897621023694, 10340.37957722539, 9717.951410242904, 10033.598656053968, 10350.948245258725, 10395.792084158425, 10508.894911051097, 7618.0, 7619.885701714589, 7665.846683066419, 7696.230376962483, 7723.150453450004, 8337.499750014777, 8343.332533397435, 8418.98972123349, 8419.579021048801, 8423.241908228289, 7468.2158373372185, 7532.698692052257, 7597.544147351176, 7681.884771728541, 7733.961330193538, 5917.940820591739, 7384.741534046282, 7464.552126872405, 7603.20166382544, 7632.19861914491, 7024.859502810017, 7064.258252883374, 7090.858182836418, 7123.430125590044, 7131.500794944304, 4329.935050974175, 4481.955180448153, 5041.823536176216, 5101.974490127525, 5151.433342332265, 4439.112177564564, 4964.702117872939, 5088.898222035613, 5153.7680804364645, 5258.263843061898], "value": 4527.016770900082, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [270.6319405608373, 300.9172477568667, 305.4623862002875, 311.1490074645845, 323.3532934131737, 5266.789328426863, 5353.437889021655, 5444.428335024815, 5612.915806262904, 5705.857353566158, 4977.038661996106, 5268.92096618551, 5427.3215848019, 5462.235287059805, 5496.80761173358, 3632.945505817415, 3868.9226215475674, 3983.9800800996027, 4159.688023398242, 4163.333866581347, 3915.7650540967493, 4090.4477895484174, 4149.9792501037455, 4283.121959998209, 4293.785310734466, 3587.856485740567, 4092.1611069730634, 4105.158442519277, 4124.298869192229, 4151.4395556599775, 4134.036332741954, 4151.937720934188, 4181.498220213563, 4202.537720850704, 4214.4195926527555, 3209.582754241957, 3256.0394683568406, 3566.8394922228563, 3600.4419315006216, 3603.7837729736298, 4514.390557274792, 4758.904821903542, 5057.671251368686, 5333.733313334318, 5434.266374039533, 4164.375343698439, 4194.391813187101, 4745.667803253774, 4755.690880092783, 4781.474037855833, 5821.912671309934, 5822.621529600562, 5839.649621022752, 5843.5033022193165, 5849.707514624251, 3565.94651080234, 3669.8348574313954, 3896.707746918964, 3902.921941561153, 3906.980465097685, 6074.96962515189, 6095.207623008981, 6098.847528811771, 6122.8775424491705, 6153.446189842935, 3985.163115745726, 3991.964098309883, 3999.1002024544828, 3999.2001599679597, 4033.0, 3754.948614387976, 3841.7153333899673, 4042.757434553936, 4055.47278853753, 4061.5126184858004, 4716.891530490332, 4729.69256998294, 4749.311349854321, 4769.689970151929, 4786.210275304606, 4758.952410475851, 4832.975835120802, 4896.436909755353, 5926.67403292823, 5991.580589358703, 1151.7811615792973, 1176.4000359816384, 1303.8696130386886, 1304.1860003473935, 1359.6125104345215, 816.9632366543519, 832.0805509911581, 848.762346542969, 850.5619605902965, 853.4836423963537, 3994.2410941920944, 4191.841201781085, 4257.638100761408, 4547.727136371828, 4606.470255920545, 4598.218302888517, 5009.320013792603, 5058.570021548209, 5069.518395752398, 5121.923171152435, 3825.139343647713, 4161.8370038770145, 4459.375687403766, 4634.6987445816585, 4664.55686709762, 2261.5024694567496, 2265.59219340517, 2494.1893884487613, 2643.7488438598302, 2657.870405077834, 4833.438277712818, 4908.226851828706, 5180.740962951837, 5203.16749320107, 5311.892542862469, 4152.754173747863, 4419.1382680377665, 4425.026494171278, 4704.553067458586, 4890.486498917562, 4050.797460126982, 4324.956750432455, 4846.8788280292565, 4954.126606568182, 5271.603025198249, 4494.6629002825575, 4530.501644819002, 4801.9039619208115, 5089.796408143781, 5117.462666419972, 4048.78925917043, 4903.754812259302, 4986.952739924656, 5019.372578427697, 5032.3961124665275, 4827.176101980381, 5184.948150518447, 5187.92218116721, 5189.766460509361, 5207.29701490294, 3479.7042251408916, 3498.6676265754713, 3504.8948531544092, 3511.9297614047064, 3549.391197469909, 4546.863594092182, 5017.899642007213, 5037.697738135724, 5090.676424129679, 5688.5733569981585, 4630.83792067276, 5808.390119037609, 5817.0, 5882.794102206402, 5928.8814223716145, 4810.39870016248, 5100.7610167543135, 5878.118282257696, 5908.911366329595, 5933.910991335047, 5376.838694839161, 5739.598228124159, 5782.537397008314, 5791.797287094932, 5822.737976791139, 5858.602010833621, 5899.587028908107, 5945.316288626863, 5978.611390259619, 6025.78909738157, 5174.654589806602, 5272.2882410874045, 5643.2472405851295, 5763.308402991668, 5895.528357731457], "value": 3960.215211808787, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [679.7145199016412, 687.972481100756, 699.6431819771915, 740.8259059121106, 741.021851156473, 15442.382304707813, 15474.381024759025, 15844.920775396107, 15902.284397202126, 16030.358785648574, 11471.942640286787, 14356.569302920903, 14468.348924298405, 14484.493042743507, 14488.985770996034, 847.1359213602107, 879.9956000219989, 882.3779235638859, 885.4421714320001, 892.6786356911507, 666.9799906002828, 882.4484697064335, 889.5463313710022, 896.5293221058931, 898.7842917699737, 868.2793281576309, 909.4497828813571, 927.939683920543, 932.4172392254841, 933.2394098809483, 902.1700035966926, 929.6885543342988, 932.2495391210073, 932.6549176804625, 939.4832841936942, 691.7060249393987, 703.6130128429395, 705.2806137739477, 706.1455638677206, 707.6072779607316, 15396.0, 15457.149856757875, 15632.0, 15651.452199172974, 15705.607359815982, 11394.71513212168, 14430.422783088663, 14503.56489305312, 14520.782188267185, 14652.0, 10092.848607270897, 11294.774104517863, 11892.405379731066, 12004.459799308965, 12130.878691213064, 3781.6785573226307, 3849.326367885637, 3867.9806600967095, 3973.5033120859894, 3990.940135897964, 130515.34742326228, 131400.0, 133456.0, 134048.32975835155, 134466.327668362, 10875.782484350428, 11049.154163754696, 11107.333559986426, 11115.888841111648, 11178.0, 22786.8860655699, 22849.428764281027, 22866.771332286797, 22889.656655150186, 22956.540869182856, 8046.356291496666, 8071.313938315191, 8089.312408445348, 8152.470089444168, 8168.0, 4406.449193850769, 4442.087840750851, 4515.932261016087, 4594.081183763261, 4606.792694328763, 3502.527158833525, 3657.6159503252306, 3664.670179683841, 3669.376206044979, 3674.577423596267, 644.5005121031238, 665.8634979829123, 668.9230738465138, 681.0329332348077, 690.9654517274116, 505.8229619633099, 543.3859738495474, 607.9878402431926, 623.3859648246473, 638.3329420755229, 7994.520328780175, 8126.959365203136, 8558.844555984986, 8814.206721394978, 9486.430814151174, 567.9062954612442, 600.8227572866015, 610.8961476548998, 619.3280290884351, 628.2241431831684, 3914.001929508014, 3935.8389275163895, 4029.879103626896, 4218.367244913287, 4238.855509012549, 124981.0, 133063.0, 154358.0, 163791.0, 163926.0, 139687.0, 143424.28287858493, 147059.0, 150974.0, 154934.0, 105077.0, 110047.44976275068, 119941.0, 124564.37717811353, 125277.0, 7535.944967704635, 7613.809654758454, 8196.508209507449, 8595.613197406257, 8653.567321634018, 51923.74038129785, 58367.0, 66831.66584167047, 69068.0, 70469.6476517614, 63161.684191580585, 70897.0, 75785.0, 82010.17989820025, 82400.0, 13181.143225690299, 13278.933605331911, 13386.933065335, 13417.66455838612, 13568.660783480493, 14475.855241447873, 14564.49024284145, 15565.610859728597, 15636.609084772972, 16202.0, 13384.732305354033, 14132.717345652823, 14727.92636036813, 14759.557213283619, 14784.48254311094, 11635.767284654428, 11752.941235293769, 13811.930940345233, 13816.516421925586, 14462.987590868539, 13241.801372979606, 13283.601491955256, 13283.66790830237, 13479.595612131652, 13482.19106853592, 11034.779304414027, 11037.668869933916, 11246.66260012201, 11571.942140289244, 11834.52661893549, 9752.46361450127, 11343.489542970421, 11418.942905285421, 11426.314421134759, 11496.94251528737], "value": 7840.120096988568, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1597.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 119.0, 119.0, 119.0, 121.0, 122.0, 139.0, 117.0, 120.0, 119.0], "value": 120.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 121.0, 98.0, 163.0, 141.0, 141.0, 112.0, 144.0, 171.0, 95.0], "value": 131.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [273.0, 277.0, 196.0, 254.0, 211.0, 199.0, 275.0, 210.0, 277.0, 274.0], "value": 244.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 58.0, 56.0, 103.0, 60.0, 52.0, 71.0, 84.0, 68.0, 69.0], "value": 71.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 71.0, 114.0, 105.0, 92.0, 69.0, 88.0, 73.0, 87.0, 112.0], "value": 89.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 88.0, 85.0, 106.0, 110.0, 88.0, 89.0, 89.0, 109.0], "value": 93.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 100.0, 98.0, 100.0, 108.0, 171.0, 122.0, 105.0, 97.0, 110.0], "value": 110.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 95.0, 91.0, 151.0, 120.0, 90.0, 129.0, 146.0, 104.0, 150.0], "value": 117.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 51.0, 53.0, 52.0, 58.0, 57.0, 59.0, 64.0, 77.0, 82.0], "value": 60.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 70.0, 78.0, 71.0, 71.0, 81.0, 94.0, 71.0, 70.0], "value": 74.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 97.0, 109.0, 106.0, 77.0, 85.0, 74.0, 86.0, 91.0, 73.0], "value": 87.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 159.0, 136.0, 132.0, 159.0, 161.0, 141.0, 145.0, 167.0, 166.0], "value": 150.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 149.0, 204.0, 232.0, 220.0, 167.0, 160.0, 163.0, 162.0, 164.0], "value": 178.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 64.0, 67.0, 68.0, 65.0, 68.0, 67.0, 67.0, 65.0], "value": 66.8, "unit": "score"}]}]} 16:48:46 INFO - Return code: 0 16:48:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:48:46 ERROR - # TBPL SUCCESS # 16:48:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:48:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:48:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:48:46 INFO - 2016-10-04 16:48:46.716 screenresolution[1954:12229] starting screenresolution argv=screenresolution get 16:48:46 INFO - 2016-10-04 16:48:46.719 screenresolution[1954:12229] Display 0: 1600x1200x32@60 16:48:46 INFO - 2016-10-04 16:48:46.725 screenresolution[1955:12232] starting screenresolution argv=screenresolution list 16:48:46 INFO - Available Modes on Display 0 16:48:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:48:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:48:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:48:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:48:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:48:46 INFO - Intel Iris: 16:48:46 INFO - Chipset Model: Intel Iris 16:48:46 INFO - Type: GPU 16:48:46 INFO - Bus: Built-In 16:48:46 INFO - VRAM (Dynamic, Max): 1536 MB 16:48:46 INFO - Vendor: Intel (0x8086) 16:48:46 INFO - Device ID: 0x0a2e 16:48:46 INFO - Revision ID: 0x0009 16:48:46 INFO - Displays: 16:48:46 INFO - Display: 16:48:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:48:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:48:46 INFO - Display Serial Number: 1600x1200 60 16:48:46 INFO - Main Display: Yes 16:48:46 INFO - Mirror: Off 16:48:46 INFO - Online: Yes 16:48:46 INFO - Rotation: Supported 16:48:46 INFO - Return code: 0 16:48:46 INFO - Running post-action listener: _resource_record_post_action 16:48:46 INFO - [mozharness: 2016-10-04 23:48:46.961385Z] Finished run-tests step (success) 16:48:46 INFO - Running post-run listener: _resource_record_post_run 16:48:47 INFO - Total resource usage - Wall time: 1207s; CPU: 55.0%; Read bytes: 2281472; Write bytes: 663631872; Read time: 27; Write time: 1934 16:48:47 INFO - TinderboxPrint: CPU usage
54.7% 16:48:47 INFO - TinderboxPrint: I/O read bytes / time
2,281,472 / 27 16:48:47 INFO - TinderboxPrint: I/O write bytes / time
663,631,872 / 1,934 16:48:47 INFO - TinderboxPrint: CPU idle
2,189.1 (45.3%) 16:48:47 INFO - TinderboxPrint: CPU system
986.2 (20.4%) 16:48:47 INFO - TinderboxPrint: CPU user
1,654.4 (34.3%) 16:48:47 INFO - TinderboxPrint: Swap in / out
366,206,976 / 0 16:48:47 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 363831808; Write bytes: 366176256; Read time: 27645; Write time: 781 16:48:47 INFO - run-tests - Wall time: 1176s; CPU: 55.0%; Read bytes: 1298432; Write bytes: 295940096; Read time: 21; Write time: 1143 16:48:47 INFO - Running post-run listener: _upload_blobber_files 16:48:47 INFO - Blob upload gear active. 16:48:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:48:47 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 16:48:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:48:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:48:47 INFO - (blobuploader) - INFO - Open directory for files ... 16:48:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:48:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:48:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:48:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:48:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:48:48 INFO - (blobuploader) - INFO - Done attempting. 16:48:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:48:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:48:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:48:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:48:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:48:49 INFO - (blobuploader) - INFO - Done attempting. 16:48:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:48:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:48:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:48:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:48:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:48:52 INFO - (blobuploader) - INFO - Done attempting. 16:48:52 INFO - (blobuploader) - INFO - Iteration through files over. 16:48:52 INFO - Return code: 0 16:48:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:48:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:48:52 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8c8da3c868ab75813f28be9ca3acbdc02b179c126f77455492a3ad76064f92a070b191b0006895ce0a530a4e3a7df2e69a6a6a1c5bbd24a81780a3f041bedb4e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bed162e32f344969a1b3fb814631ada60187066a02c89f0b9d917ece7e59a69749849aaa3d07f0f6adda8f3518f99cfc5d76e27d510060d3f0c02edd6ad10a1a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eb97fd52a7208702c5bac7c8261a40157bf3ce703db1b3beefc86e54b8772e8fcc79b0b46db3ccc87d0b471fa2f6b45cb78566faf4b45d2f8bf404debef235f0"} 16:48:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:48:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:48:52 INFO - Contents: 16:48:52 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8c8da3c868ab75813f28be9ca3acbdc02b179c126f77455492a3ad76064f92a070b191b0006895ce0a530a4e3a7df2e69a6a6a1c5bbd24a81780a3f041bedb4e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bed162e32f344969a1b3fb814631ada60187066a02c89f0b9d917ece7e59a69749849aaa3d07f0f6adda8f3518f99cfc5d76e27d510060d3f0c02edd6ad10a1a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eb97fd52a7208702c5bac7c8261a40157bf3ce703db1b3beefc86e54b8772e8fcc79b0b46db3ccc87d0b471fa2f6b45cb78566faf4b45d2f8bf404debef235f0"} 16:48:52 INFO - Running post-run listener: copy_logs_to_upload_dir 16:48:52 INFO - Copying logs to upload dir... 16:48:52 INFO - mkdir: /builds/slave/test/build/upload/logs 16:48:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.709807 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-10-04 16:48:52.548821) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 16:48:52.552365) ========= 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.2mHKXON1RT/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.6wKJUywe9t/Listeners TMPDIR=/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8c8da3c868ab75813f28be9ca3acbdc02b179c126f77455492a3ad76064f92a070b191b0006895ce0a530a4e3a7df2e69a6a6a1c5bbd24a81780a3f041bedb4e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bed162e32f344969a1b3fb814631ada60187066a02c89f0b9d917ece7e59a69749849aaa3d07f0f6adda8f3518f99cfc5d76e27d510060d3f0c02edd6ad10a1a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eb97fd52a7208702c5bac7c8261a40157bf3ce703db1b3beefc86e54b8772e8fcc79b0b46db3ccc87d0b471fa2f6b45cb78566faf4b45d2f8bf404debef235f0"} build_url:https://queue.taskcluster.net/v1/task/NatTCfiTR2C6PcYNvCwB4Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011235 build_url: 'https://queue.taskcluster.net/v1/task/NatTCfiTR2C6PcYNvCwB4Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8c8da3c868ab75813f28be9ca3acbdc02b179c126f77455492a3ad76064f92a070b191b0006895ce0a530a4e3a7df2e69a6a6a1c5bbd24a81780a3f041bedb4e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bed162e32f344969a1b3fb814631ada60187066a02c89f0b9d917ece7e59a69749849aaa3d07f0f6adda8f3518f99cfc5d76e27d510060d3f0c02edd6ad10a1a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eb97fd52a7208702c5bac7c8261a40157bf3ce703db1b3beefc86e54b8772e8fcc79b0b46db3ccc87d0b471fa2f6b45cb78566faf4b45d2f8bf404debef235f0"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 16:48:52.589374) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 16:48:52.590115) ========= 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.2mHKXON1RT/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.6wKJUywe9t/Listeners TMPDIR=/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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.005229 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 16:48:52.642426) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 16:48:52.643089) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 16:48:52.643799) ========= ========= Total master_lag: 0.20 =========