builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0178 starttime: 1479016585.88 results: success (0) buildid: 20161112201720 builduid: a19926e6383246c3817ad2945d761894 revision: b54268561e8cb9ddaff7452e7ef9f7e181ad59fa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-12 21:56:25.883558) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-12 21:56:25.883914) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-12 21:56:25.884183) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-12 21:56:26.001183) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-12 21:56:26.001450) ========= 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.tAESFzYuwF/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.W7BCjvV5ct/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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-11-12 21:56:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.59M=0.001s 2016-11-12 21:56:26 (8.59 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.488462 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-12 21:56:26.546644) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-12 21:56:26.546937) ========= 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.tAESFzYuwF/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.W7BCjvV5ct/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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.019816 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-12 21:56:26.614791) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-12 21:56:26.615124) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b54268561e8cb9ddaff7452e7ef9f7e181ad59fa --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 b54268561e8cb9ddaff7452e7ef9f7e181ad59fa --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.tAESFzYuwF/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.W7BCjvV5ct/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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-11-12 21:56:26,696 truncating revision to first 12 chars 2016-11-12 21:56:26,696 Setting DEBUG logging. 2016-11-12 21:56:26,696 attempt 1/10 2016-11-12 21:56:26,696 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/b54268561e8c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-12 21:56:27,343 unpacking tar archive at: mozilla-aurora-b54268561e8c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.916062 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-12 21:56:27.558186) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-12 21:56:27.558477) ========= script_repo_revision: b54268561e8cb9ddaff7452e7ef9f7e181ad59fa ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-12 21:56:27.561862) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-12 21:56:27.562134) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-12 21:56:27.584542) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-11-12 21:56:27.584838) ========= /tools/buildbot/bin/python -u 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', '-u', '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.tAESFzYuwF/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.W7BCjvV5ct/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 21:56:27 INFO - MultiFileLogger online at 20161112 21:56:27 in /builds/slave/test 21:56:27 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 21:56:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:56:27 INFO - {'append_to_log': False, 21:56:27 INFO - 'base_work_dir': '/builds/slave/test', 21:56:27 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 21:56:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:56:27 INFO - 'branch': 'Mozilla-Aurora', 21:56:27 INFO - 'buildbot_json_path': 'buildprops.json', 21:56:27 INFO - 'config_files': ('talos/mac_config.py',), 21:56:27 INFO - 'default_actions': ('clobber', 21:56:27 INFO - 'read-buildbot-config', 21:56:27 INFO - 'download-and-extract', 21:56:27 INFO - 'populate-webroot', 21:56:27 INFO - 'create-virtualenv', 21:56:27 INFO - 'install', 21:56:27 INFO - 'run-tests'), 21:56:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:56:27 INFO - 'download_minidump_stackwalk': True, 21:56:27 INFO - 'download_symbols': 'ondemand', 21:56:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:56:27 INFO - 'tooltool.py': '/tools/tooltool.py', 21:56:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:56:27 INFO - '/tools/misc-python/virtualenv.py')}, 21:56:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:56:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:56:27 INFO - 'installer_path': 'installer.exe', 21:56:27 INFO - 'log_level': 'info', 21:56:27 INFO - 'log_name': 'talos', 21:56:27 INFO - 'log_to_console': True, 21:56:27 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:56:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:56:27 INFO - 'opt_config_files': (), 21:56:27 INFO - 'pip_index': False, 21:56:27 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:56:27 INFO - 'cmd': ('bash', 21:56:27 INFO - '-c', 21:56:27 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:56:27 INFO - 'enabled': True, 21:56:27 INFO - 'halt_on_failure': False, 21:56:27 INFO - 'name': 'check_screen_resolution'},), 21:56:27 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:56:27 INFO - 'cmd': ('bash', 21:56:27 INFO - '-c', 21:56:27 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:56:27 INFO - 'enabled': True, 21:56:27 INFO - 'halt_on_failure': False, 21:56:27 INFO - 'name': 'check_screen_resolution'},), 21:56:27 INFO - 'run_cmd_checks_enabled': True, 21:56:27 INFO - 'sps_profile': False, 21:56:27 INFO - 'sps_profile_interval': 0, 21:56:27 INFO - 'suite': 'dromaeojs-e10s', 21:56:27 INFO - 'system_bits': '32', 21:56:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:56:27 INFO - 'title': 't-yosemite-r7-0178', 21:56:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:56:27 INFO - 'use_talos_json': True, 21:56:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:56:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:56:27 INFO - 'work_dir': 'build'} 21:56:27 INFO - [mozharness: 2016-11-13 05:56:27.784790Z] Running clobber step. 21:56:27 INFO - Running pre-action listener: _resource_record_pre_action 21:56:27 INFO - Running main action method: clobber 21:56:27 INFO - rmtree: /builds/slave/test/build 21:56:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:56:29 INFO - Running post-action listener: _resource_record_post_action 21:56:29 INFO - [mozharness: 2016-11-13 05:56:29.828081Z] Finished clobber step (success) 21:56:29 INFO - [mozharness: 2016-11-13 05:56:29.828216Z] Running read-buildbot-config step. 21:56:29 INFO - Running pre-action listener: _resource_record_pre_action 21:56:29 INFO - Running main action method: read_buildbot_config 21:56:29 INFO - Using buildbot properties: 21:56:29 INFO - { 21:56:29 INFO - "project": "", 21:56:29 INFO - "product": "firefox", 21:56:29 INFO - "script_repo_revision": "production", 21:56:29 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 21:56:29 INFO - "repository": "", 21:56:29 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 21:56:29 INFO - "buildid": "20161112201720", 21:56:29 INFO - "pgo_build": "False", 21:56:29 INFO - "basedir": "/builds/slave/test", 21:56:29 INFO - "buildnumber": 157, 21:56:29 INFO - "slavename": "t-yosemite-r7-0178", 21:56:29 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 21:56:29 INFO - "platform": "yosemite_r7", 21:56:29 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 21:56:29 INFO - "branch": "mozilla-aurora", 21:56:29 INFO - "repo_path": "releases/mozilla-aurora", 21:56:29 INFO - "revision": "b54268561e8cb9ddaff7452e7ef9f7e181ad59fa", 21:56:29 INFO - "stage_platform": "macosx64", 21:56:29 INFO - "builduid": "a19926e6383246c3817ad2945d761894", 21:56:29 INFO - "slavebuilddir": "test" 21:56:29 INFO - } 21:56:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/Fg527KEhTUS1A0MuetLz4g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 21:56:29 INFO - Running post-action listener: _resource_record_post_action 21:56:29 INFO - [mozharness: 2016-11-13 05:56:29.831451Z] Finished read-buildbot-config step (success) 21:56:29 INFO - [mozharness: 2016-11-13 05:56:29.831562Z] Running download-and-extract step. 21:56:29 INFO - Running pre-action listener: _resource_record_pre_action 21:56:29 INFO - Running main action method: download_and_extract 21:56:29 INFO - mkdir: /builds/slave/test/build/tests 21:56:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:56:29 INFO - trying https://queue.taskcluster.net/v1/task/Fg527KEhTUS1A0MuetLz4g/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 21:56:29 INFO - Downloading https://queue.taskcluster.net/v1/task/Fg527KEhTUS1A0MuetLz4g/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 21:56:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Fg527KEhTUS1A0MuetLz4g/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 21:56:30 INFO - Downloaded 1199 bytes. 21:56:30 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 21:56:30 INFO - Using the following test package requirements: 21:56:30 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 21:56:30 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:56:30 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 21:56:30 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:56:30 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 21:56:30 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:56:30 INFO - u'jsshell-mac.zip'], 21:56:30 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:56:30 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 21:56:30 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 21:56:30 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:56:30 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 21:56:30 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:56:30 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 21:56:30 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:56:30 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 21:56:30 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:56:30 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 21:56:30 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 21:56:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Fg527KEhTUS1A0MuetLz4g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 21:56:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Fg527KEhTUS1A0MuetLz4g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 21:56:30 INFO - Fetch https://queue.taskcluster.net/v1/task/Fg527KEhTUS1A0MuetLz4g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 21:56:31 INFO - Expected file size: 16423780 21:56:38 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 21:56:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Fg527KEhTUS1A0MuetLz4g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 21:56:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Fg527KEhTUS1A0MuetLz4g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 21:56:38 INFO - Fetch https://queue.taskcluster.net/v1/task/Fg527KEhTUS1A0MuetLz4g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 21:56:39 INFO - Expected file size: 16423780 21:56:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Fg527KEhTUS1A0MuetLz4g/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 21:56:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Fg527KEhTUS1A0MuetLz4g/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 21:56:45 INFO - Fetch https://queue.taskcluster.net/v1/task/Fg527KEhTUS1A0MuetLz4g/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 21:56:46 INFO - Expected file size: 14414089 21:56:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:56:46 INFO - trying https://queue.taskcluster.net/v1/task/Fg527KEhTUS1A0MuetLz4g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 21:56:46 INFO - Downloading https://queue.taskcluster.net/v1/task/Fg527KEhTUS1A0MuetLz4g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 21:56:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Fg527KEhTUS1A0MuetLz4g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 21:56:49 INFO - Downloaded 115554683 bytes. 21:56:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Fg527KEhTUS1A0MuetLz4g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 21:56:49 INFO - mkdir: /builds/slave/test/properties 21:56:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:56:49 INFO - Writing to file /builds/slave/test/properties/build_url 21:56:49 INFO - Contents: 21:56:49 INFO - build_url:https://queue.taskcluster.net/v1/task/Fg527KEhTUS1A0MuetLz4g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 21:56:50 INFO - Running post-action listener: _resource_record_post_action 21:56:50 INFO - Running post-action listener: set_extra_try_arguments 21:56:50 INFO - [mozharness: 2016-11-13 05:56:50.582061Z] Finished download-and-extract step (success) 21:56:50 INFO - [mozharness: 2016-11-13 05:56:50.582208Z] Running populate-webroot step. 21:56:50 INFO - Running pre-action listener: _resource_record_pre_action 21:56:50 INFO - Running main action method: populate_webroot 21:56:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:56:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:56:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:56:50 INFO - '--tppagecycles', 21:56:50 INFO - '7'], 21:56:50 INFO - 'tests': ['tsvgm']}}, 21:56:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:56:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:56:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:56:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:56:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:56:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:56:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:56:50 INFO - 'talos_options': ['--disable-e10s'], 21:56:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:56:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:56:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:56:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:56:50 INFO - 'talos_options': ['--disable-e10s'], 21:56:50 INFO - 'tests': ['damp', 'tps']}, 21:56:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:56:50 INFO - 'tests': ['damp', 'tps']}, 21:56:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:56:50 INFO - 'tests': ['dromaeo_dom']}, 21:56:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:56:50 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:56:50 INFO - 'tests': ['basic_compositor_video']}, 21:56:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:56:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:56:50 INFO - 'tests': ['a11yr', 21:56:50 INFO - 'ts_paint', 21:56:50 INFO - 'tpaint', 21:56:50 INFO - 'sessionrestore', 21:56:50 INFO - 'sessionrestore_no_auto_restore', 21:56:50 INFO - 'tabpaint']}, 21:56:50 INFO - 'other-e10s': {'tests': ['a11yr', 21:56:50 INFO - 'ts_paint', 21:56:50 INFO - 'tpaint', 21:56:50 INFO - 'sessionrestore', 21:56:50 INFO - 'sessionrestore_no_auto_restore', 21:56:50 INFO - 'tabpaint']}, 21:56:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:56:50 INFO - 'ts_paint', 21:56:50 INFO - 'tpaint', 21:56:50 INFO - 'sessionrestore', 21:56:50 INFO - 'sessionrestore_no_auto_restore', 21:56:50 INFO - 'tabpaint']}, 21:56:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:56:50 INFO - 'ts_paint', 21:56:50 INFO - 'tpaint', 21:56:50 INFO - 'sessionrestore', 21:56:50 INFO - 'sessionrestore_no_auto_restore', 21:56:50 INFO - 'tabpaint']}, 21:56:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:56:50 INFO - 'tests': ['a11yr', 21:56:50 INFO - 'ts_paint', 21:56:50 INFO - 'tpaint', 21:56:50 INFO - 'sessionrestore', 21:56:50 INFO - 'sessionrestore_no_auto_restore', 21:56:50 INFO - 'tabpaint']}, 21:56:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:56:50 INFO - 'tests': ['a11yr', 21:56:50 INFO - 'ts_paint', 21:56:50 INFO - 'tpaint', 21:56:50 INFO - 'sessionrestore', 21:56:50 INFO - 'sessionrestore_no_auto_restore', 21:56:50 INFO - 'tabpaint']}, 21:56:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:56:50 INFO - 'tests': ['tsvgx', 21:56:50 INFO - 'tsvgr_opacity', 21:56:50 INFO - 'tart', 21:56:50 INFO - 'tscrollx', 21:56:50 INFO - 'cart']}, 21:56:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:56:50 INFO - 'tsvgr_opacity', 21:56:50 INFO - 'tart', 21:56:50 INFO - 'tscrollx', 21:56:50 INFO - 'cart']}, 21:56:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:56:50 INFO - 'talos_options': ['--disable-e10s'], 21:56:50 INFO - 'tests': ['tp5o']}, 21:56:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:56:50 INFO - 'tests': ['tp5o']}, 21:56:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:56:50 INFO - 'talos_options': ['--disable-e10s', 21:56:50 INFO - '--xperf_path', 21:56:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:56:50 INFO - 'tests': ['tp5n']}, 21:56:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:56:50 INFO - 'talos_options': ['--xperf_path', 21:56:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:56:50 INFO - 'tests': ['tp5n']}}, 21:56:50 INFO - 'talos.zip': {'path': '', 21:56:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:56:50 INFO - Running post-action listener: _resource_record_post_action 21:56:50 INFO - [mozharness: 2016-11-13 05:56:50.601520Z] Finished populate-webroot step (success) 21:56:50 INFO - [mozharness: 2016-11-13 05:56:50.601627Z] Running create-virtualenv step. 21:56:50 INFO - Running pre-action listener: _resource_record_pre_action 21:56:50 INFO - Running main action method: create_virtualenv 21:56:50 INFO - Creating virtualenv /builds/slave/test/build/venv 21:56:50 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 21:56:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:56:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:56:50 INFO - Using real prefix '/tools/python27' 21:56:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:56:51 INFO - Installing distribute.............................................................................................................................................................................................done. 21:56:54 INFO - Installing pip.................done. 21:56:54 INFO - Return code: 0 21:56:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:56:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:56:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:56:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:54 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 0x10913d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090b3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd829d92950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f51d30>, '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 0x108db7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f49b20>, '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.tAESFzYuwF/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.W7BCjvV5ct/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 21:56:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:56:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:56:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tAESFzYuwF/Render', 21:56:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:56:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:56:54 INFO - 'HOME': '/Users/cltbld', 21:56:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:56:54 INFO - 'LOGNAME': 'cltbld', 21:56:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:54 INFO - 'MOZ_NO_REMOTE': '1', 21:56:54 INFO - 'NO_EM_RESTART': '1', 21:56:54 INFO - 'PAGER': '/bin/cat', 21:56:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:56:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:56:54 INFO - 'PWD': '/builds/slave/test', 21:56:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:56:54 INFO - 'SHELL': '/bin/bash', 21:56:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W7BCjvV5ct/Listeners', 21:56:54 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 21:56:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:56:54 INFO - 'USER': 'cltbld', 21:56:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:56:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:56:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:54 INFO - 'XPC_FLAGS': '0x0', 21:56:54 INFO - 'XPC_SERVICE_NAME': '0', 21:56:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:56:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:54 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 21:56:54 INFO - Cleaning up... 21:56:54 INFO - Return code: 0 21:56:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:56:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:56:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:56:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:54 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 0x10913d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090b3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd829d92950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f51d30>, '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 0x108db7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f49b20>, '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.tAESFzYuwF/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.W7BCjvV5ct/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 21:56:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 21:56:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 21:56:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tAESFzYuwF/Render', 21:56:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:56:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:56:54 INFO - 'HOME': '/Users/cltbld', 21:56:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:56:54 INFO - 'LOGNAME': 'cltbld', 21:56:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:54 INFO - 'MOZ_NO_REMOTE': '1', 21:56:54 INFO - 'NO_EM_RESTART': '1', 21:56:54 INFO - 'PAGER': '/bin/cat', 21:56:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:56:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:56:54 INFO - 'PWD': '/builds/slave/test', 21:56:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:56:54 INFO - 'SHELL': '/bin/bash', 21:56:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W7BCjvV5ct/Listeners', 21:56:54 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 21:56:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:56:54 INFO - 'USER': 'cltbld', 21:56:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:56:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:56:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:54 INFO - 'XPC_FLAGS': '0x0', 21:56:54 INFO - 'XPC_SERVICE_NAME': '0', 21:56:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:56:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:54 INFO - Downloading/unpacking psutil>=3.1.1 21:56:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:56:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:56:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:56:58 INFO - Installing collected packages: psutil 21:56:58 INFO - Running setup.py install for psutil 21:56:58 INFO - building 'psutil._psutil_osx' extension 21:56:58 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 21:56:58 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 21:56:58 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 21:56:58 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 21:56:58 INFO - building 'psutil._psutil_posix' extension 21:56:58 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 21:56:58 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:56:58 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:56:58 INFO - ^ 21:56:58 INFO - 1 warning generated. 21:56:58 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 21:56:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:56:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:56:59 INFO - Successfully installed psutil 21:56:59 INFO - Cleaning up... 21:56:59 INFO - Return code: 0 21:56:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:56:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:56:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:56:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:59 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 0x10913d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090b3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd829d92950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f51d30>, '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 0x108db7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f49b20>, '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.tAESFzYuwF/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.W7BCjvV5ct/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 21:56:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 21:56:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 21:56:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tAESFzYuwF/Render', 21:56:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:56:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:56:59 INFO - 'HOME': '/Users/cltbld', 21:56:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:56:59 INFO - 'LOGNAME': 'cltbld', 21:56:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:59 INFO - 'MOZ_NO_REMOTE': '1', 21:56:59 INFO - 'NO_EM_RESTART': '1', 21:56:59 INFO - 'PAGER': '/bin/cat', 21:56:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:56:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:56:59 INFO - 'PWD': '/builds/slave/test', 21:56:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:56:59 INFO - 'SHELL': '/bin/bash', 21:56:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W7BCjvV5ct/Listeners', 21:56:59 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 21:56:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:56:59 INFO - 'USER': 'cltbld', 21:56:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:56:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:56:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:59 INFO - 'XPC_FLAGS': '0x0', 21:56:59 INFO - 'XPC_SERVICE_NAME': '0', 21:56:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:56:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:56:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:56:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:57:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:57:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:57:02 INFO - Installing collected packages: mozsystemmonitor 21:57:02 INFO - Running setup.py install for mozsystemmonitor 21:57:02 INFO - Successfully installed mozsystemmonitor 21:57:02 INFO - Cleaning up... 21:57:02 INFO - Return code: 0 21:57:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:57:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:57:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:57:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:57:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10913d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090b3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd829d92950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f51d30>, '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 0x108db7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f49b20>, '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.tAESFzYuwF/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.W7BCjvV5ct/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 21:57:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 21:57:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 21:57:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tAESFzYuwF/Render', 21:57:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:57:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:57:02 INFO - 'HOME': '/Users/cltbld', 21:57:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:57:02 INFO - 'LOGNAME': 'cltbld', 21:57:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:57:02 INFO - 'MOZ_NO_REMOTE': '1', 21:57:02 INFO - 'NO_EM_RESTART': '1', 21:57:02 INFO - 'PAGER': '/bin/cat', 21:57:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:57:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:57:02 INFO - 'PWD': '/builds/slave/test', 21:57:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:57:02 INFO - 'SHELL': '/bin/bash', 21:57:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W7BCjvV5ct/Listeners', 21:57:02 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 21:57:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:57:02 INFO - 'USER': 'cltbld', 21:57:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:57:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:57:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:57:02 INFO - 'XPC_FLAGS': '0x0', 21:57:02 INFO - 'XPC_SERVICE_NAME': '0', 21:57:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:57:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:57:02 INFO - Downloading/unpacking jsonschema==2.5.1 21:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:57:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:57:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:57:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:57:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:57:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:57:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:57:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:57:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:57:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:57:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:57:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:57:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:57:05 INFO - Downloading functools32-3.2.3-2.tar.gz 21:57:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:57:05 INFO - warning: no files found matching '*.txt' 21:57:05 INFO - no previously-included directories found matching 'build' 21:57:05 INFO - no previously-included directories found matching 'dist' 21:57:05 INFO - no previously-included directories found matching '.git*' 21:57:05 INFO - Installing collected packages: jsonschema, functools32 21:57:05 INFO - Running setup.py install for functools32 21:57:05 INFO - warning: no files found matching '*.txt' 21:57:05 INFO - no previously-included directories found matching 'build' 21:57:05 INFO - no previously-included directories found matching 'dist' 21:57:05 INFO - no previously-included directories found matching '.git*' 21:57:05 INFO - Successfully installed jsonschema functools32 21:57:05 INFO - Cleaning up... 21:57:05 INFO - Return code: 0 21:57:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:57: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')]} 21:57:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:57:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57: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')]} 21:57:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:57:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10913d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090b3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd829d92950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f51d30>, '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 0x108db7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f49b20>, '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.tAESFzYuwF/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.W7BCjvV5ct/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 21:57:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:57:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 21:57:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tAESFzYuwF/Render', 21:57:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:57:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:57:05 INFO - 'HOME': '/Users/cltbld', 21:57:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:57:05 INFO - 'LOGNAME': 'cltbld', 21:57:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:57:05 INFO - 'MOZ_NO_REMOTE': '1', 21:57:05 INFO - 'NO_EM_RESTART': '1', 21:57:05 INFO - 'PAGER': '/bin/cat', 21:57:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:57:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:57:05 INFO - 'PWD': '/builds/slave/test', 21:57:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:57:05 INFO - 'SHELL': '/bin/bash', 21:57:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W7BCjvV5ct/Listeners', 21:57:05 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 21:57:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:57:05 INFO - 'USER': 'cltbld', 21:57:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:57:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:57:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:57:05 INFO - 'XPC_FLAGS': '0x0', 21:57:05 INFO - 'XPC_SERVICE_NAME': '0', 21:57:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:57:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:57:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:57:06 INFO - Cleaning up... 21:57:06 INFO - Return code: 0 21:57:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:57:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:57:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:57:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:57:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57:06 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 0x10913d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090b3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd829d92950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f51d30>, '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 0x108db7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f49b20>, '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.tAESFzYuwF/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.W7BCjvV5ct/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 21:57:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:57:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:57:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tAESFzYuwF/Render', 21:57:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:57:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:57:06 INFO - 'HOME': '/Users/cltbld', 21:57:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:57:06 INFO - 'LOGNAME': 'cltbld', 21:57:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:57:06 INFO - 'MOZ_NO_REMOTE': '1', 21:57:06 INFO - 'NO_EM_RESTART': '1', 21:57:06 INFO - 'PAGER': '/bin/cat', 21:57:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:57:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:57:06 INFO - 'PWD': '/builds/slave/test', 21:57:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:57:06 INFO - 'SHELL': '/bin/bash', 21:57:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W7BCjvV5ct/Listeners', 21:57:06 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 21:57:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:57:06 INFO - 'USER': 'cltbld', 21:57:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:57:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:57:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:57:06 INFO - 'XPC_FLAGS': '0x0', 21:57:06 INFO - 'XPC_SERVICE_NAME': '0', 21:57:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:57:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:57:06 INFO - Downloading/unpacking blobuploader==1.2.4 21:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:57:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:57:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:57:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:57:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:57:08 INFO - Downloading blobuploader-1.2.4.tar.gz 21:57:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:57:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:57:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:57:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:57:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:57:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:57:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:57:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:57:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:57:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:57:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:57:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:57:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:57:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:57:10 INFO - Downloading docopt-0.6.1.tar.gz 21:57:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:57:10 INFO - Installing collected packages: blobuploader, requests, docopt 21:57:10 INFO - Running setup.py install for blobuploader 21:57:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:57:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:57:10 INFO - Running setup.py install for requests 21:57:10 INFO - Running setup.py install for docopt 21:57:10 INFO - Successfully installed blobuploader requests docopt 21:57:10 INFO - Cleaning up... 21:57:11 INFO - Return code: 0 21:57:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:57:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:57:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:57:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:57:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:57:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57:11 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 0x10913d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090b3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd829d92950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f51d30>, '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 0x108db7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f49b20>, '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.tAESFzYuwF/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.W7BCjvV5ct/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 21:57:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:57:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:57:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tAESFzYuwF/Render', 21:57:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:57:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:57:11 INFO - 'HOME': '/Users/cltbld', 21:57:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:57:11 INFO - 'LOGNAME': 'cltbld', 21:57:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:57:11 INFO - 'MOZ_NO_REMOTE': '1', 21:57:11 INFO - 'NO_EM_RESTART': '1', 21:57:11 INFO - 'PAGER': '/bin/cat', 21:57:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:57:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:57:11 INFO - 'PWD': '/builds/slave/test', 21:57:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:57:11 INFO - 'SHELL': '/bin/bash', 21:57:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W7BCjvV5ct/Listeners', 21:57:11 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 21:57:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:57:11 INFO - 'USER': 'cltbld', 21:57:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:57:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:57:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:57:11 INFO - 'XPC_FLAGS': '0x0', 21:57:11 INFO - 'XPC_SERVICE_NAME': '0', 21:57:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:57:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:57:11 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-QBgB6M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:57:11 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-yiFs30-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:57:11 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-_HMaHH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:57:11 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-E1WcGn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:57:11 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-59UhmV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:57:11 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-yApXo6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:57:11 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-XdoWDR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:57:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:57:12 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-yORp7E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:57:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:57:12 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-0wsgdF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:57:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:57:12 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-wKsDfW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:57:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:57:12 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-LeYAF2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:57:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:57:12 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-K0cLAp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:57:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:57:12 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-EANi1c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:57:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:57:12 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-vi0O6O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:57:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:57:12 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-2R1bcY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:57:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:57:12 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-L6jtN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:57:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:57:12 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-MwTDML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:57:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:57:13 INFO - Running setup.py install for manifestparser 21:57:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:57:13 INFO - Running setup.py install for mozcrash 21:57:13 INFO - Running setup.py install for mozdebug 21:57:13 INFO - Running setup.py install for mozdevice 21:57:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:57:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:57:13 INFO - Running setup.py install for mozfile 21:57:13 INFO - Running setup.py install for mozhttpd 21:57:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:57:13 INFO - Running setup.py install for mozinfo 21:57:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:57:14 INFO - Running setup.py install for mozInstall 21:57:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:57:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:57:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:57:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:57:14 INFO - Running setup.py install for mozleak 21:57:14 INFO - Running setup.py install for mozlog 21:57:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:57:14 INFO - Running setup.py install for moznetwork 21:57:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:57:14 INFO - Running setup.py install for mozprocess 21:57:14 INFO - Running setup.py install for mozprofile 21:57:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:57:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:57:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:57:15 INFO - Running setup.py install for mozrunner 21:57:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:57:15 INFO - Running setup.py install for mozscreenshot 21:57:15 INFO - Running setup.py install for moztest 21:57:15 INFO - Running setup.py install for mozversion 21:57:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:57:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:57:15 INFO - Cleaning up... 21:57:15 INFO - Return code: 0 21:57:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:57:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:57:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:57:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:57:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:57:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57:15 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 0x10913d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090b3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd829d92950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f51d30>, '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 0x108db7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f49b20>, '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.tAESFzYuwF/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.W7BCjvV5ct/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 21:57:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:57:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:57:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tAESFzYuwF/Render', 21:57:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:57:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:57:15 INFO - 'HOME': '/Users/cltbld', 21:57:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:57:15 INFO - 'LOGNAME': 'cltbld', 21:57:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:57:15 INFO - 'MOZ_NO_REMOTE': '1', 21:57:15 INFO - 'NO_EM_RESTART': '1', 21:57:15 INFO - 'PAGER': '/bin/cat', 21:57:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:57:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:57:15 INFO - 'PWD': '/builds/slave/test', 21:57:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:57:15 INFO - 'SHELL': '/bin/bash', 21:57:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W7BCjvV5ct/Listeners', 21:57:15 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 21:57:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:57:15 INFO - 'USER': 'cltbld', 21:57:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:57:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:57:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:57:15 INFO - 'XPC_FLAGS': '0x0', 21:57:15 INFO - 'XPC_SERVICE_NAME': '0', 21:57:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:57:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:57:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:57:15 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-udeeQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:57:16 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 21:57:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:57:16 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-XxWeIN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:57:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:57:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:57:16 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-20iYOV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:57:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:57:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:57:16 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-yLqtko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:57:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:57:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:57:16 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-73dinE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:57:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 21:57:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:57:16 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-VkXemd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:57:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 21:57:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:57:16 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-dn5kj3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:57:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 21:57:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:57:16 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-t4Kuqw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:57:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 21:57:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:57:16 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-BwiOhR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:57:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 21:57:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:57:16 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-o8qV0j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:57:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:57:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:57:16 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-gFDhLw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:57:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 21:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:57:17 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-US2HrM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:57:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 21:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:57:17 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-SD62dv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:57:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 21:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:57:17 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-fQfW5y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:57:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 21:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:57:17 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-Dxvrbx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:57:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 21:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:57:17 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-bI4BtU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:57:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 21:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:57:17 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-wJxcKF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:57:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 21:57:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:57:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:57:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:57:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:57:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:57:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:57: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 21:57: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 21:57: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 21:57: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 21:57: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 21:57: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 21:57:20 INFO - Downloading blessings-1.6.tar.gz 21:57:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:57:20 INFO - Installing collected packages: blessings 21:57:20 INFO - Running setup.py install for blessings 21:57:20 INFO - Successfully installed blessings 21:57:20 INFO - Cleaning up... 21:57:20 INFO - Return code: 0 21:57:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:57:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:57:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:57:20 INFO - Reading from file tmpfile_stdout 21:57:20 INFO - Current package versions: 21:57:20 INFO - blessings == 1.6 21:57:20 INFO - blobuploader == 1.2.4 21:57:20 INFO - docopt == 0.6.1 21:57:20 INFO - functools32 == 3.2.3-2 21:57:20 INFO - jsonschema == 2.5.1 21:57:20 INFO - manifestparser == 1.1 21:57:20 INFO - mozInstall == 1.12 21:57:20 INFO - mozcrash == 0.17 21:57:20 INFO - mozdebug == 0.1 21:57:20 INFO - mozdevice == 0.48 21:57:20 INFO - mozfile == 1.2 21:57:20 INFO - mozhttpd == 0.7 21:57:20 INFO - mozinfo == 0.9 21:57:20 INFO - mozleak == 0.1 21:57:20 INFO - mozlog == 3.4 21:57:20 INFO - moznetwork == 0.27 21:57:20 INFO - mozprocess == 0.23 21:57:20 INFO - mozprofile == 0.28 21:57:20 INFO - mozrunner == 6.12 21:57:20 INFO - mozscreenshot == 0.1 21:57:20 INFO - mozsystemmonitor == 0.3 21:57:20 INFO - moztest == 0.7 21:57:20 INFO - mozversion == 1.4 21:57:20 INFO - psutil == 3.1.1 21:57:20 INFO - requests == 1.2.3 21:57:20 INFO - wsgiref == 0.1.2 21:57:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:57: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')]} 21:57:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:57:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57: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')]} 21:57:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:57:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57:20 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 0x10913d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090b3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd829d92950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f51d30>, '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 0x108db7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f49b20>, '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.tAESFzYuwF/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.W7BCjvV5ct/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 21:57:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 21:57:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:57:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tAESFzYuwF/Render', 21:57:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:57:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:57:20 INFO - 'HOME': '/Users/cltbld', 21:57:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:57:20 INFO - 'LOGNAME': 'cltbld', 21:57:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:57:20 INFO - 'MOZ_NO_REMOTE': '1', 21:57:20 INFO - 'NO_EM_RESTART': '1', 21:57:20 INFO - 'PAGER': '/bin/cat', 21:57:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:57:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:57:20 INFO - 'PWD': '/builds/slave/test', 21:57:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:57:20 INFO - 'SHELL': '/bin/bash', 21:57:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W7BCjvV5ct/Listeners', 21:57:20 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 21:57:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:57:20 INFO - 'USER': 'cltbld', 21:57:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:57:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:57:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:57:20 INFO - 'XPC_FLAGS': '0x0', 21:57:20 INFO - 'XPC_SERVICE_NAME': '0', 21:57:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:57:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:57:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:57:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 21:57:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 21:57:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:57:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 21:57:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 21:57:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 21:57:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 21:57:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 21:57:21 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:57:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:57:21 INFO - Cleaning up... 21:57:21 INFO - Return code: 0 21:57:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:57:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:57:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:57:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:57:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:57:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57:21 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 0x10913d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090b3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd829d92950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f51d30>, '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 0x108db7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f49b20>, '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.tAESFzYuwF/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.W7BCjvV5ct/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 21:57:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:57:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:57:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tAESFzYuwF/Render', 21:57:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:57:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:57:21 INFO - 'HOME': '/Users/cltbld', 21:57:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:57:21 INFO - 'LOGNAME': 'cltbld', 21:57:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:57:21 INFO - 'MOZ_NO_REMOTE': '1', 21:57:21 INFO - 'NO_EM_RESTART': '1', 21:57:21 INFO - 'PAGER': '/bin/cat', 21:57:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:57:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:57:21 INFO - 'PWD': '/builds/slave/test', 21:57:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:57:21 INFO - 'SHELL': '/bin/bash', 21:57:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W7BCjvV5ct/Listeners', 21:57:21 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 21:57:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:57:21 INFO - 'USER': 'cltbld', 21:57:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:57:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:57:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:57:21 INFO - 'XPC_FLAGS': '0x0', 21:57:21 INFO - 'XPC_SERVICE_NAME': '0', 21:57:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:57:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:57:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:57:21 INFO - Cleaning up... 21:57:21 INFO - Return code: 0 21:57:21 INFO - Running post-action listener: _resource_record_post_action 21:57:21 INFO - Running post-action listener: _start_resource_monitoring 21:57:21 INFO - Starting resource monitoring. 21:57:21 INFO - [mozharness: 2016-11-13 05:57:21.505766Z] Finished create-virtualenv step (success) 21:57:21 INFO - [mozharness: 2016-11-13 05:57:21.506751Z] Running install step. 21:57:21 INFO - Running pre-action listener: _resource_record_pre_action 21:57:21 INFO - Running main action method: install 21:57:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:57:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:57:21 INFO - Reading from file tmpfile_stdout 21:57:21 INFO - Detecting whether we're running mozinstall >=1.0... 21:57:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:57:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:57:21 INFO - Reading from file tmpfile_stdout 21:57:21 INFO - Output received: 21:57:21 INFO - Usage: mozinstall [options] installer 21:57:21 INFO - Options: 21:57:21 INFO - -h, --help show this help message and exit 21:57:21 INFO - -d DEST, --destination=DEST 21:57:21 INFO - Directory to install application into. [default: 21:57:21 INFO - "/builds/slave/test"] 21:57:21 INFO - --app=APP Application being installed. [default: firefox] 21:57:21 INFO - mkdir: /builds/slave/test/build/application 21:57:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 21:57:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 21:57:53 INFO - Reading from file tmpfile_stdout 21:57:53 INFO - Output received: 21:57:53 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 21:57:53 INFO - Running post-action listener: _resource_record_post_action 21:57:53 INFO - [mozharness: 2016-11-13 05:57:53.998791Z] Finished install step (success) 21:57:53 INFO - [mozharness: 2016-11-13 05:57:53.998944Z] Running run-tests step. 21:57:53 INFO - Running pre-action listener: _resource_record_pre_action 21:57:53 INFO - Running main action method: run_tests 21:57:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:57:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:57:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:57:54 INFO - 2016-11-12 21:57:54.013 screenresolution[1944:20635] starting screenresolution argv=screenresolution get 21:57:54 INFO - 2016-11-12 21:57:54.016 screenresolution[1944:20635] Display 0: 1600x1200x32@60 21:57:54 INFO - 2016-11-12 21:57:54.021 screenresolution[1945:20637] starting screenresolution argv=screenresolution list 21:57:54 INFO - Available Modes on Display 0 21:57:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:57:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:57:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:57:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:57:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:57:54 INFO - Intel Iris: 21:57:54 INFO - Chipset Model: Intel Iris 21:57:54 INFO - Type: GPU 21:57:54 INFO - Bus: Built-In 21:57:54 INFO - VRAM (Dynamic, Max): 1536 MB 21:57:54 INFO - Vendor: Intel (0x8086) 21:57:54 INFO - Device ID: 0x0a2e 21:57:54 INFO - Revision ID: 0x0009 21:57:54 INFO - Displays: 21:57:54 INFO - Display: 21:57:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:57:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:57:54 INFO - Display Serial Number: 1600x1200 60 21:57:54 INFO - Main Display: Yes 21:57:54 INFO - Mirror: Off 21:57:54 INFO - Online: Yes 21:57:54 INFO - Rotation: Supported 21:57:54 INFO - Return code: 0 21:57:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:57:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:57:54 INFO - Python 2.7.3 21:57:54 INFO - Return code: 0 21:57:54 INFO - grabbing minidump binary from tooltool 21:57:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:57:54 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 0x108f51d30>, '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 0x108db7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f49b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:57:54 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 21:57:54 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 21:57:54 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 21:57:54 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:57:54 INFO - Return code: 0 21:57:54 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 21:57:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:57:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:57:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 21:57:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:57:54 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/Fg527KEhTUS1A0MuetLz4g/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0178', '--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 21:57:54 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/Fg527KEhTUS1A0MuetLz4g/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0178 --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 21:57:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tAESFzYuwF/Render', 21:57:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:57:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:57:54 INFO - 'HOME': '/Users/cltbld', 21:57:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:57:54 INFO - 'LOGNAME': 'cltbld', 21:57:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:57:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 21:57:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:57:54 INFO - 'MOZ_NO_REMOTE': '1', 21:57:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:57:54 INFO - 'NO_EM_RESTART': '1', 21:57:54 INFO - 'PAGER': '/bin/cat', 21:57:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:57:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:57:54 INFO - 'PWD': '/builds/slave/test', 21:57:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:57:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:57:54 INFO - 'SHELL': '/bin/bash', 21:57:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.W7BCjvV5ct/Listeners', 21:57:54 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 21:57:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:57:54 INFO - 'USER': 'cltbld', 21:57:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:57:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:57:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:57:54 INFO - 'XPC_FLAGS': '0x0', 21:57:54 INFO - 'XPC_SERVICE_NAME': '0', 21:57:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:57:54 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/Fg527KEhTUS1A0MuetLz4g/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0178', '--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 21:57:54 INFO - mozversion application_buildid: 20161112201720 21:57:54 INFO - mozversion application_changeset: b54268561e8cb9ddaff7452e7ef9f7e181ad59fa 21:57:54 INFO - mozversion application_display_name: FirefoxDeveloperEdition 21:57:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:57:54 INFO - mozversion application_name: Firefox 21:57:54 INFO - mozversion application_remotingname: firefox-dev 21:57:54 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 21:57:54 INFO - mozversion application_vendor: Mozilla 21:57:54 INFO - mozversion application_version: 51.0a2 21:57:54 INFO - mozversion platform_buildid: 20161112201720 21:57:54 INFO - mozversion platform_changeset: b54268561e8cb9ddaff7452e7ef9f7e181ad59fa 21:57:54 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 21:57:54 INFO - mozversion platform_version: 51.0a2 21:57:54 INFO - using testdate: 1479016674 21:57:54 INFO - actual date: 1479016674 21:57:54 INFO - starting webserver on 'localhost:56644' 21:57:54 INFO - SUITE-START | Running 2 tests 21:57:54 INFO - TEST-START | dromaeo_css 21:57:54 INFO - operating with platform_type : mac_ 21:57:54 INFO - Initialising browser for dromaeo_css test... 21:57:54 INFO - TEST-INFO | started process 1955 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/tmpzY4vD3/profile http://localhost:56644/getInfo.html) 21:57:57 INFO - PROCESS | 1955 | __metrics Screen width/height:1600/1200 21:57:57 INFO - PROCESS | 1955 | colorDepth:24 21:57:57 INFO - PROCESS | 1955 | Browser inner width/height: 1024/689 21:57:57 INFO - PROCESS | 1955 | __metrics 21:57:57 ERROR - PROCESS | 1955 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 21:57:58 INFO - TEST-INFO | 1955: exit 0 21:57:58 INFO - Browser initialized. 21:57:58 INFO - Running cycle 1/1 for dromaeo_css test... 21:57:58 INFO - TEST-INFO | started process 1958 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/tmpzY4vD3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:58:10 INFO - PROCESS | 1958 | RSS: Main: 225767424 21:58:10 INFO - PROCESS | 1958 | 21:58:59 INFO - PROCESS | 1958 | 1479016739825 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] 22:01:12 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:56644/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56644/tests/dromaeo/cssquery-ext.html) 22:01:13 INFO - PROCESS | 1958 | RSS: Main: 237256704 22:01:13 INFO - PROCESS | 1958 | 22:04:15 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:56644/tests/dromaeo/cssquery-ext.html (next: http://localhost:56644/tests/dromaeo/cssquery-jquery.html) 22:04:16 INFO - PROCESS | 1958 | RSS: Main: 248401920 22:04:16 INFO - PROCESS | 1958 | 22:07:18 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:56644/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56644/tests/dromaeo/cssquery-mootools.html) 22:07:19 INFO - PROCESS | 1958 | RSS: Main: 251863040 22:07:19 INFO - PROCESS | 1958 | 22:10:21 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:56644/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56644/tests/dromaeo/cssquery-prototype.html) 22:10:21 INFO - PROCESS | 1958 | RSS: Main: 252022784 22:10:21 INFO - PROCESS | 1958 | 22:13:24 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:56644/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56644/tests/dromaeo/cssquery-yui.html) 22:13:25 INFO - PROCESS | 1958 | RSS: Main: 256630784 22:13:25 INFO - PROCESS | 1958 | 22:16:27 INFO - PROCESS | 1958 | Cycle 1(1): loaded http://localhost:56644/tests/dromaeo/cssquery-yui.html (next: http://localhost:56644/tests/dromaeo/cssquery-dojo.html) 22:16:27 INFO - PROCESS | 1958 | RSS: Main: 259624960 22:16:27 INFO - PROCESS | 1958 | 22:16:27 INFO - PROCESS | 1958 | __start_tp_report 22:16:27 INFO - PROCESS | 1958 | _x_x_mozilla_page_load 22:16:27 INFO - PROCESS | 1958 | _x_x_mozilla_page_load_details 22:16:27 INFO - PROCESS | 1958 | |i|pagename|runs| 22:16:27 INFO - PROCESS | 1958 | |0;dojo.html;3390.1524618845306;3393.3213357328536;3407.1141503209165;3419.1281223288056;3439.2605589798204;5733.856653583663;5762.481376676098;5780.161876527901;5780.710964451776;5790.623609465381;5793.33376661684;5842.532597392209;5866.120081987693;5883.676397798119;5922.466977971982;5266.578673706094;5344.7862085516535;5353.197020446925;5355.732213389334;5356.9732151339385;5366.221897824813;5373.785048598052;5393.838184854441;5400.756965936543;5439.0209762242785;5252.579793616521;5258.763355649005;5351.7056561889085;5365.302510673607;5370;4309.504406993205;4376.431063961696;5271.604629652772;5283.154695248761;5297.867553311159;5219.895602087975;5261.552768014723;5280.551153151987;5316.787328506855;5380.515753582157;4548.2495388260895;4660.510646382115;5709.286339207599;5845.473907348359;5937.228160339128;5126.974365128188;6184.041473571604;6297.244330680302;6299.811005669837;6316.526260530479;6228.128062071269;6279.837683004441;6290.087937249119;6291.245050593912;6301.905471417932;5730.828075157752;5780.971095144498;5847.619904706181;5945.31628862682;5953.434423729782;6242.75028998844;6306.936930630727;6345.873082538324;6355.904661430082;6368.267649220399;6228.314885362606;6245.0632405139595;6250.531210159256;6259.3427690091885;6270.2789179244055;6142.897836592581;6157.661328626879;6316.684165791692;6319.526035547352;6331.525135614847;6170.475509581646;6215.471684906744;6243.469305109116;6250.062490626351;6281.246250449975;6238.376162383725;6248.5313601480075;6297.118403423525;6321.083442900754;6323.083152942798;4840.467548569725;4962.5533701967;4969.527894849984;4975.253711943165;4988.5260900214425;4425.911481770347;4426.667999900021;4442.73343599385;4456.24243878535;4514.390557274792;5883.94116058834;5969.641821490724;5971.492423144082;5974.4324289192455;5992.520598352121;6178.135061091451;6203.534734894901;6279.811605651837;6295.433410992941;6301.7164227609865;5889.528837692974;5951.5238780897425;5973.940260597426;6012.977793775069;6051.273847138372;5446.482584154499;5447.12845944647;5472.945270547323;5473.480019398151;5480.534154596824;6166.321704612579;6346.4605508532295;6353.396427339396;6353.5870168438905;6371.490280777527;6204.441600255998;6229.719662615103;6233.937660623335;6261.7182226799;6301.7164227608955;6285.779997700059;6291.993281075189;6296.653684047421;6317.778877739257;6324.620522768649;6189.381061893775;6199.3490683477585;6199.473044791243;6205.596636218631;6208.689565521796;6121.8493044937295;6163.568550201622;6190.0714892764645;6203.100550420254;6226.470749986302;6196.411340922605;6196.721147548281;6200.844978875564;6208.565400422108;6215;6159.014557670751;6161.229846269216;6186.257649082139;6198;6213.2233470816145;5802.47777700009;5861;6017.939820601738;6048.4858787003595;6057.848553786191;6177.382261773787;6186.721597528032;6212.06818977157;6230.906536401867;6233.189685340877;5030.320906677698;6065.423784740619;6084.300305464928;6087.69561521931;6093.299270583762 22:16:27 INFO - PROCESS | 1958 | |1;ext.html;495.3510900720057;499.8675351031976;509.4803300633353;514.5240652396537;527.0591993291974;38748.22503549931;40503;40650.186996260054;40657.39013914794;40703.185936281254;41960.790196048976;42355.36466952998;42449.7877510612;42588.36117458241;42598.574014259924;9886.999999999982;10061.094501494865;10091.192704583653;10091.29360944734;10187.694369168938;9924;10013.59945602175;10017.348872323311;10020.498975051254;10024.198064154887;10003.199744020461;10027.699169024905;10033.448160351178;10039.698809035704;10066.29535932485;9939.652112176076;9990.150837178848;10000.099991000772;10005.699829005105;10019.699409017741;9837.213022958145;9842.163416109639;9844.212463003014;9889.75275618108;9952.90047099527;40094.198116037514;40253.39619905704;40365.394519082234;40388;40497.79751101255;3015.9698403016127;3129.4836352001894;3277.3117645294515;3760.304343696425;3782.6973842092566;29263.2684182895;30220.546691799642;30505;30623.846880765675;31052.8447357764;3106.3942531206426;3152.290734584723;3210.96789032109;3247.0908145719236;3271.2312606537444;513303;514888;515645;518161.9999999962;518512;56778.716106419204;56890.14664780031;56934.71532642393;57192.142117868265;57495.712521437126;34081.48877766835;34273.82863085669;34567.82716086454;36032.45951310732;59322.110168347506;16777.07726075053;16998.83001169997;17020.57448563771;17022.893511921684;17046.57383565396;12824.166429182073;12907.548235811702;13005.674858128623;13036.087473876738;13043.739125217633;18850;18856.811431885504;18880.905595471933;18889;18920.33778817735;7852.214778522102;7966.9601651992525;7969.800754981055;8030.839383212303;8045.316148127475;826.3719573124469;865.7446053414258;945.2768631996528;968.6173961285253;974.8001659659752;28777.42445151085;30331.241718957204;30389.544156837666;30705.078847634606;30800.691993080232;1001.159026417798;1052.6368402900987;1069.812782763029;1120.8710998235144;1131.6491887514896;15545.689086218212;15759.212039397984;15770.921145394199;15794;16025.919870400807;589615;689362.5531872308;697795;703270.4836475888;704581;57410.42589574134;57422.425775742544;57761.422385776445;58037;58111.41888581144;1346.912450690702;1348.4134401535364;1351.175782772508;1355.2410650036209;1380.1029330934973;24433;29416.26459338534;29868;30024;30494.84752576223;48564.51435485741;48708.5129148704;49173;49173.26240106473;49257;636415;645754;646020;646416;647165;42683;42704.78647606742;43204.56795432005;43406.56593434025;43407.612581308334;40688.79655601703;45038.324425134306;46256.07487850157;46858.531414685414;47135.764321178176;28551;31602;33604.83197584094;38275.66035188755;38839.41740873833;31388;38565.22869542537;38586.22827543489;39498.40752388659;39771.40342894917;37995;38027.61972380241;38957.6104238954;39017;40155.59844401519;31267.84366078155;31647.36705265928;34783.304333913686;35210;35286.647133528335;25810.87094564515;25846.22461326163;25884.35289117787;26275.73724262733;26351.73648263493 22:16:27 INFO - PROCESS | 1958 | |2;jquery.html;377.15893557367065;378.18123762055154;383.98656047038327;384.4982298100978;401.85131501344506;19021.144048517814;20137.395878123643;21080.472988175305;21421.357359279227;21506.462338441506;11551.018163456096;12075.2151110178;12102;12135.635930922064;18112.094395280248;5228.137357336035;5511.311086114236;5514.779408823642;5518.724063796814;5522.282103326582;5270.657407268515;5388.78444862205;5464.808731694391;5469.972650136764;5504.64219825712;5337.813176538822;5367.570594352443;5450.264214331074;5459.099248623972;5479.150731636582;4775.522447755214;5355.732213389315;6207.099970504251;6216.844578885519;6241.594296370721;5867.765289388462;6066.272047354301;6069.02895536712;6092.329843717188;6097.390260973912;13008.544700935421;13185.406656700472;13248.205107693473;13324.400401981935;13326;2117.2589593642256;2255.763144869798;2592.792576593868;2884.6538415390078;2946.0572616762643;9766.658166964122;9856.704298871045;9948.751281217956;10368.844467332996;10408.687739367831;1659.9751003734953;1820;1822.9270829166817;1855.9072046397625;1957.9021048947495;118216.8178318223;118862.40568797187;126311.36844315812;127614;129500;11601.361925094201;11731.002864756421;11741.706457338463;12028.458719357475;12091.45588448522;14758.704825903422;14802.777958330633;14803;14822.481213157704;14857.108573485626;8204.83590328202;8296.668133274723;8586.356023298278;8785.945686517658;8804.647814087364;8517.190866867637;8602.655893764178;8636.654533818702;8791.681247812752;8865.867011994826;4479.731216127043;4571.862844114682;4611.400517932647;4617.820872110745;4628.4445866496235;1909.9331523396615;1950.9414717558495;1952.2971730177126;1959.4023822734202;1960.2453055573708;775.573434610973;816.1185919207361;830.7839961610025;839.2195258409615;913.7395842185078;15466.304016319293;17154;17368.78418510692;21146.78853211479;21156.78843211548;883.6332921837366;887.671561522241;917.729269865378;988.8615593816871;1020.9030142136485;10621.5220315086;11241.437928103562;11278.210525263317;11278.943605282086;11302.547898083985;578364;586544;596153;602210;604037;72746.27253727501;126931;131274;133433;134357;942.1097063275276;950.396498223633;979.8383266761048;980.8773903262093;984.2814745235875;18833.529161771065;19076.713849291995;19539.804601953798;19744.40766776999;19787.802121978595;54493;55504.72247638736;56591.01931432545;57767.71116144393;58303.4169658298;79102.6044869772;80711;82270.58864705877;84211;86355.70466443134;7969.6015199238645;8123.18768123183;8139.267465928095;8370.66517339324;8389.993200815941;11215.887841121485;12390.504379824706;12492.063095268073;12751.681207969876;12781.04142189321;10699.358038517714;10825.458727063458;10953.068989135694;10956.233063685466;11151.944240278746;9132.908670913472;10747.247692661438;10820.350778953289;10994.34033957965;11133.610323638957;9462.817147856518;10625.25623206399;11141.164412669244;11234.55061797519;11441.199116061796;6101.633901965896;7772.650230739743;7969.561674107979;8001.359891208573;8159.755207343789;8627.266682332072;10954.287971281841;10971.341719496855;11184.944075279896;11288.717782055513 22:16:27 INFO - PROCESS | 1958 | |3;mootools.html;1501.0768377447866;1529.5411376587024;1600.8559229669327;1743.9361989186593;1840.8987505687198;7994.280514753671;8243.052049014364;8478.788030299238;9070.818583628332;9101.90898091019;8584.48493090415;8842.381033327654;8855.95572022139;8973.416727912698;8988.640454381833;2357.4342157882115;2372.134171027571;2407.9277621671376;2410.5901996660523;2411.493586346869;2021.8281446077028;2407.193590147294;2414.4326083370393;2419.068658566447;2422.0432928993037;2393.533261014103;2399.5800734871414;2409.132712223598;2416.178499310234;2418.733939266679;2170.8060566688414;2173.271953895431;2365.3377054424705;2373.774491423312;2394.365493144318;2013.7382140321665;2359.00921612923;2384.3443053160345;2387.164492427654;2389.462370966536;8872.11278872114;8925.152110549487;8944.284457243404;8950.149735775156;8962.775930601721;4830.806767729287;5179.249008893727;5343.412224655323;5422.593305502063;5426.403095659474;3141.780075394723;3508.1405055761247;3519.9120021999656;3653.488511608377;3682.9447558286647;1040.2146379483518;1055.5672174408533;1072.0405237312561;1076.2412499188054;1081.3133660125798;11671.474783634756;11708.238964467282;11727.472263748152;11739.530418783324;11834.881651183465;4608.631309495232;4727.314539391769;4815.975920120377;4854.199057155601;4879.926801097987;9978.750531236632;10079.647212347532;10088.344257623232;10089.596416143419;10094.596216151418;5411.107167317348;5411.729413529387;5414.242006119146;5416.864578385572;5426.782928682808;4352.956470435319;4520.073384956077;4780.115678599401;4911.361523002059;4941.950580494149;3558.484019817112;3984.143409167043;4008.3386241269864;4082.5302890959233;4138.461999939988;1277.8083287506947;1311.4426368793415;1314.7764879970428;1322.5238913990956;1324.5628942448968;737.0749709115026;782.5226611766818;820.4789958376355;857.9914200858036;872.4067634008808;5524.839783645399;5642.605017648725;5689.544836413077;5775.306963164448;6000.639961602318;794.9761507154794;877.4954401219325;884.5975081337975;953.1850268020881;987.0820137272406;3742.3825068863875;3830.4637350770913;3831.1762970961377;3942.3692209246383;4084.8366065357054;10782.568697252022;10840.891591084146;10843;10851.51168197433;11027.22809403334;10815.242932994615;10815.513301901434;10922.1808364373;10922.672319830417;10959.780804383867;7799.376049916106;8091.1504292048485;8174.7956301092945;8183.427160098736;8326;5836.095405212199;5919.200907877554;5966.797020576614;5978.7608495661425;5980.013297805987;10005.199584033115;10066.094051535398;10093.949530252596;10202.846957295795;10226.744331391776;9833.557489912828;10183.796324073624;10254.897451025692;10379.948100259451;10382.688519344432;6972.302769722987;7193.388561972291;7387.593682347308;7420.888686669597;7593.506422082547;8342.12407697183;8388.119247478928;8448.619812108347;8485.95757021211;8521.062683104978;6364.459020983269;7401.888971665322;7564.281393267851;7567.697292108254;7640;7281.745138920112;7349.8162545936775;7367.963160184165;7382.926170738224;7427.034485516848;6918.377346038881;7005.474589405713;7072.575645461289;7088.716451341888;7210;4892.535209155125;4893.461719210955;4914.729689867092;4940.308356830118;4958.206686930074;4104.630583247522;4590.747508887043;4866.586340161126;4905.632077594123;5025.723585202702 22:16:27 INFO - PROCESS | 1958 | |4;prototype.html;264.7458439897698;278.72127872127874;296.7952113042001;310.09297803923516;311.8129122526483;5029.346184995946;5106.876487172825;5451.809186678467;5482.342118945727;5548.472895074967;4259.1038094096;4525.796339164737;4736.573708366246;5386.814900721844;5517.668939863611;3453.3783918894587;3861.3049651062797;4019.9397009044887;4153.341861208821;4161.10536234711;4029.6373326400617;4188.371744238373;4190.811413486401;4196.097838964622;4205.85279515217;3560.181158333585;3825.5791862895057;4109.9108736184935;4154.169166166764;4177.830207541893;4125.401816736587;4142.1301526679135;4166.437530933315;4175.519815221242;4180.644645205146;3589;3596.1009747563107;3596.820158992066;3613.5483064616924;3616.806453870243;5054.671446355975;5243.8164664236565;5259.211118332242;5302.681839089667;5320.228566857822;4526.411566496367;4781.713097214143;4799.544043315879;4844.8304309349005;4847.3698419205275;5016.799328026875;5344.22508736235;5756.942430575683;5778.7688492460675;5785.739641716133;3837.884863454101;3936.311145549546;3962;3971.940420893689;3972.8149517765114;4807.591354734816;5458.235846981426;5552.222688823608;5957.970210148921;6041.6072955258205;3349.894534803509;3609.9278014440088;4047.291723948297;4058.1477889643506;4063.4311196432523;3622.9637703623152;3778.4899038629983;3929.44987701722;4055.91888162241;4134.421181034658;3961.959590810735;4013.337799263147;4684.344191813149;4743.960097158255;4774;5140.665856719302;5766.4233576642;5802.274715660543;5828.766849326064;5838.241028666331;1156.6414411532453;1246.9812952805714;1324.8079028540808;1373.6497193215666;1378.945106993151;915.4919019943862;929.9814003720023;941.6892425499568;948.1608776232946;948.5020364308793;4335.3713711511655;5292.364916210079;5301.83359660874;5436.483534064258;5535.955224626439;5468.890622187534;5941.55438342126;5966.433188847052;6013.4064472914715;6045.697715114226;4990.151674215392;5175.197844334134;5287.446997337511;5300.681959082467;5397.541208997201;2306.285051633999;2311.549247896644;2352.9764402613737;2571.996921200733;2613.777828884528;4666.416697912761;4717.3631559739;4851.733154676526;5111.693298402108;5112.239390728964;4665.906681866411;4734.692245004064;4975.243691013334;5009.549140577293;5119.414695578709;4455.660778091463;4483.3723278741;4873.025394920959;5080.54275115234;5095.464976177596;4042.978510744628;4440.489343725513;4966.9817687374725;4972.872515811795;4975.308395145667;4427.756473393994;4547.840825571089;4830.739251005487;4879.267859909823;4936.520462286787;4701.764911754467;5070.630929649048;5075.974620126875;5085.644004919768;5117.26013155514;3495.650434956484;3507.701845343174;3509.78941263525;3584.301061293127;3592.6766591006935;4073;4444.311131774451;4670.696404733681;4950.554450099508;5556.472135147154;5859.589828711949;5989.341172471112;5992.310884248367;5999.550033747573;6004.249468816398;4578.908421831478;5165.638405311592;5664.461876121762;5827.708614569339;5895.764169433346;5572.93801293524;5656.575756818337;5657.660540367591;5664.0937450007805;5715.771369145187;5549.916751248816;5721.425358588568;5842.795502157404;5869.853253668522;5895.818547137586;5089.694618322913;5249.291345668286;5492.80775172867;5750.30996280449;5778.537716982547 22:16:27 INFO - PROCESS | 1958 | |5;yui.html;692.857964117356;703.6587255181239;705.1819888928843;714.2143641993807;714.9954314188564;15158.77261841072;15361.15513646749;15692.843071569281;15886.920565397186;15904.204789760524;14355.28223588819;14394.640133996629;14492.927535362334;14517.419303227858;14555.708885822303;840.7855996720843;857.9613917373733;863.7365603490932;865.3380164174412;873.9861760357986;687.0312858868996;704.6441547018749;844.5945945945949;868.5526953618892;878.064860923118;875.4353442029887;891.2780647675404;897.8698088777123;908.2643059122132;915.1809130827905;908.1372695938851;908.6274627402734;909.0818273543769;911.0707078779608;912.2291663544295;634.8571571396445;647.744141064277;673.7305077968851;674.7570874485182;675.1122274209399;14457.421703131862;14623.63440913975;14669.77995330071;14680.412783488648;14732.926335368255;14325.78511322331;14400.423983040666;14426.639334016629;14477.05899116554;14780;11623.953844154066;12005.039596832232;12022.819657705142;12049.397530123459;12394;3780.6786423154067;3788.488554045196;3823.216240670684;3895.1625400538737;3910.706696997708;116649;122547.38726306401;123138;123179;123710;10853.24027318096;11062.668119956414;11162.553497859995;11223.71940701489;11325.773484530264;22552.872356382115;22580.20969266068;22601.88699056494;22669.43326416853;22677.092916283495;7423.777286681408;7771.067471903408;7799.8300254962205;7827.726029588937;8104.027516697916;4324.783760811947;4466.3747075409465;4470.575295346936;4482;4648.372469716545;3499.2126771476724;3589.5692516897616;3601.7118630509494;3648.0332711831384;3654.30568192048;654.1953397321226;667.8764428580728;690.8618276344752;695.9686814093378;696.3837004251274;490.7521701540699;620.4137090449572;629.9181106456132;667.5560752099897;678.9321067893171;9327.067293270618;9456.52717364129;9495.762605934908;9561.61753529865;9656.565454554422;598.2014011294883;635.2250254689365;656.7701304543467;672.2806596941226;675.8614484030762;4272.7222730523035;4660.300954856799;4663.673542852036;4664.953350466452;4666.580007799314;96111.51944240234;113623;165505;168940;169422;114246.85753142528;119458;141765;145311;150001;121870.39064804619;122637;124373.37813310875;125123;127737.36131319284;8682.479051256945;8924.196822286025;9042.593083311136;9048.366614336934;9211.585478653342;54204;67529.6623516899;68269.65865170643;68778;69032.96450553145;98680;104764;104775.4761226189;105025.47487262514;106971.46514267378;10948.890511095105;11578.652640420802;11723.296602203895;12042.698932526757;12051.75896482048;12135.757284854077;12653.493860245488;12687.873121269038;13014.489292254118;13308.467661293827;10674.679759607225;11687.415629218674;12104.697382565506;12301.692457688629;12572.057095717675;12179.512819487476;12200.75598488043;12207.389630518615;12483.438245279165;12736.936315318364;11850.392525596264;12065.215760975509;12103.33431661267;12115.878841211475;12356.505739770668;10033.397996120257;10237.897621023694;10237.9488102559;10741.872103429027;10771.6229931952;10392.42841643717;10440.58237670515;10553.155747540332;10585.364878107339;10629.627963021258 22:16:27 INFO - PROCESS | 1958 | __end_tp_report 22:16:27 INFO - PROCESS | 1958 | __start_cc_report 22:16:27 INFO - PROCESS | 1958 | _x_x_mozilla_cycle_collect,360 22:16:27 INFO - PROCESS | 1958 | __end_cc_report 22:16:27 INFO - PROCESS | 1958 | __startTimestamp1479017787908__endTimestamp 22:16:27 INFO - PROCESS | 1958 | 22:16:27 INFO - PROCESS | 1958 | ------- Summary: start ------- 22:16:27 INFO - PROCESS | 1958 | Number of tests: 6 22:16:27 INFO - PROCESS | 1958 | 22:16:27 INFO - PROCESS | 1958 | [#0] dojo.html Cycles:165 Average:5784.13 Median:6065.42 stddev:664.06 (10.9%) stddev-sans-first:638.99 22:16:27 INFO - PROCESS | 1958 | Values: 3390.2 3393.3 3407.1 3419.1 3439.3 5733.9 5762.5 5780.2 5780.7 5790.6 5793.3 5842.5 5866.1 5883.7 5922.5 5266.6 5344.8 5353.2 5355.7 5357.0 5366.2 5373.8 5393.8 5400.8 5439.0 5252.6 5258.8 5351.7 5365.3 5370.0 4309.5 4376.4 5271.6 5283.2 5297.9 5219.9 5261.6 5280.6 5316.8 5380.5 4548.2 4660.5 5709.3 5845.5 5937.2 5127.0 6184.0 6297.2 6299.8 6316.5 6228.1 6279.8 6290.1 6291.2 6301.9 5730.8 5781.0 5847.6 5945.3 5953.4 6242.8 6306.9 6345.9 6355.9 6368.3 6228.3 6245.1 6250.5 6259.3 6270.3 6142.9 6157.7 6316.7 6319.5 6331.5 6170.5 6215.5 6243.5 6250.1 6281.2 6238.4 6248.5 6297.1 6321.1 6323.1 4840.5 4962.6 4969.5 4975.3 4988.5 4425.9 4426.7 4442.7 4456.2 4514.4 5883.9 5969.6 5971.5 5974.4 5992.5 6178.1 6203.5 6279.8 6295.4 6301.7 5889.5 5951.5 5973.9 6013.0 6051.3 5446.5 5447.1 5472.9 5473.5 5480.5 6166.3 6346.5 6353.4 6353.6 6371.5 6204.4 6229.7 6233.9 6261.7 6301.7 6285.8 6292.0 6296.7 6317.8 6324.6 6189.4 6199.3 6199.5 6205.6 6208.7 6121.8 6163.6 6190.1 6203.1 6226.5 6196.4 6196.7 6200.8 6208.6 6215.0 6159.0 6161.2 6186.3 6198.0 6213.2 5802.5 5861.0 6017.9 6048.5 6057.8 6177.4 6186.7 6212.1 6230.9 6233.2 5030.3 6065.4 6084.3 6087.7 6093.3 22:16:27 INFO - PROCESS | 1958 | 22:16:27 INFO - PROCESS | 1958 | [#1] ext.html Cycles:180 Average:73462.69 Median:38151.64 stddev:165224.06 (433.1%) stddev-sans-first:165596.73 22:16:27 INFO - PROCESS | 1958 | Values: 495.4 499.9 509.5 514.5 527.1 38748.2 40503.0 40650.2 40657.4 40703.2 41960.8 42355.4 42449.8 42588.4 42598.6 9887.0 10061.1 10091.2 10091.3 10187.7 9924.0 10013.6 10017.3 10020.5 10024.2 10003.2 10027.7 10033.4 10039.7 10066.3 9939.7 9990.2 10000.1 10005.7 10019.7 9837.2 9842.2 9844.2 9889.8 9952.9 40094.2 40253.4 40365.4 40388.0 40497.8 3016.0 3129.5 3277.3 3760.3 3782.7 29263.3 30220.5 30505.0 30623.8 31052.8 3106.4 3152.3 3211.0 3247.1 3271.2 513303.0 514888.0 515645.0 518162.0 518512.0 56778.7 56890.1 56934.7 57192.1 57495.7 34081.5 34273.8 34567.8 36032.5 59322.1 16777.1 16998.8 17020.6 17022.9 17046.6 12824.2 12907.5 13005.7 13036.1 13043.7 18850.0 18856.8 18880.9 18889.0 18920.3 7852.2 7967.0 7969.8 8030.8 8045.3 826.4 865.7 945.3 968.6 974.8 28777.4 30331.2 30389.5 30705.1 30800.7 1001.2 1052.6 1069.8 1120.9 1131.6 15545.7 15759.2 15770.9 15794.0 16025.9 589615.0 689362.6 697795.0 703270.5 704581.0 57410.4 57422.4 57761.4 58037.0 58111.4 1346.9 1348.4 1351.2 1355.2 1380.1 24433.0 29416.3 29868.0 30024.0 30494.8 48564.5 48708.5 49173.0 49173.3 49257.0 636415.0 645754.0 646020.0 646416.0 647165.0 42683.0 42704.8 43204.6 43406.6 43407.6 40688.8 45038.3 46256.1 46858.5 47135.8 28551.0 31602.0 33604.8 38275.7 38839.4 31388.0 38565.2 38586.2 39498.4 39771.4 37995.0 38027.6 38957.6 39017.0 40155.6 31267.8 31647.4 34783.3 35210.0 35286.6 25810.9 25846.2 25884.4 26275.7 26351.7 22:16:27 INFO - PROCESS | 1958 | 22:16:27 INFO - PROCESS | 1958 | [#2] jquery.html Cycles:180 Average:34430.13 Median:381.08 stddev:99316.81 (26061.7%) stddev-sans-first:99562.51 22:16:27 INFO - PROCESS | 1958 | Values: 377.2 378.2 384.0 384.5 401.9 19021.1 20137.4 21080.5 21421.4 21506.5 11551.0 12075.2 12102.0 12135.6 18112.1 5228.1 5511.3 5514.8 5518.7 5522.3 5270.7 5388.8 5464.8 5470.0 5504.6 5337.8 5367.6 5450.3 5459.1 5479.2 4775.5 5355.7 6207.1 6216.8 6241.6 5867.8 6066.3 6069.0 6092.3 6097.4 13008.5 13185.4 13248.2 13324.4 13326.0 2117.3 2255.8 2592.8 2884.7 2946.1 9766.7 9856.7 9948.8 10368.8 10408.7 1660.0 1820.0 1822.9 1855.9 1957.9 118216.8 118862.4 126311.4 127614.0 129500.0 11601.4 11731.0 11741.7 12028.5 12091.5 14758.7 14802.8 14803.0 14822.5 14857.1 8204.8 8296.7 8586.4 8785.9 8804.6 8517.2 8602.7 8636.7 8791.7 8865.9 4479.7 4571.9 4611.4 4617.8 4628.4 1909.9 1950.9 1952.3 1959.4 1960.2 775.6 816.1 830.8 839.2 913.7 15466.3 17154.0 17368.8 21146.8 21156.8 883.6 887.7 917.7 988.9 1020.9 10621.5 11241.4 11278.2 11278.9 11302.5 578364.0 586544.0 596153.0 602210.0 604037.0 72746.3 126931.0 131274.0 133433.0 134357.0 942.1 950.4 979.8 980.9 984.3 18833.5 19076.7 19539.8 19744.4 19787.8 54493.0 55504.7 56591.0 57767.7 58303.4 79102.6 80711.0 82270.6 84211.0 86355.7 7969.6 8123.2 8139.3 8370.7 8390.0 11215.9 12390.5 12492.1 12751.7 12781.0 10699.4 10825.5 10953.1 10956.2 11151.9 9132.9 10747.2 10820.4 10994.3 11133.6 9462.8 10625.3 11141.2 11234.6 11441.2 6101.6 7772.7 7969.6 8001.4 8159.8 8627.3 10954.3 10971.3 11184.9 11288.7 22:16:27 INFO - PROCESS | 1958 | 22:16:27 INFO - PROCESS | 1958 | [#3] mootools.html Cycles:180 Average:5724.04 Median:4823.39 stddev:3245.25 (67.3%) stddev-sans-first:3238.84 22:16:27 INFO - PROCESS | 1958 | Values: 1501.1 1529.5 1600.9 1743.9 1840.9 7994.3 8243.1 8478.8 9070.8 9101.9 8584.5 8842.4 8856.0 8973.4 8988.6 2357.4 2372.1 2407.9 2410.6 2411.5 2021.8 2407.2 2414.4 2419.1 2422.0 2393.5 2399.6 2409.1 2416.2 2418.7 2170.8 2173.3 2365.3 2373.8 2394.4 2013.7 2359.0 2384.3 2387.2 2389.5 8872.1 8925.2 8944.3 8950.1 8962.8 4830.8 5179.2 5343.4 5422.6 5426.4 3141.8 3508.1 3519.9 3653.5 3682.9 1040.2 1055.6 1072.0 1076.2 1081.3 11671.5 11708.2 11727.5 11739.5 11834.9 4608.6 4727.3 4816.0 4854.2 4879.9 9978.8 10079.6 10088.3 10089.6 10094.6 5411.1 5411.7 5414.2 5416.9 5426.8 4353.0 4520.1 4780.1 4911.4 4942.0 3558.5 3984.1 4008.3 4082.5 4138.5 1277.8 1311.4 1314.8 1322.5 1324.6 737.1 782.5 820.5 858.0 872.4 5524.8 5642.6 5689.5 5775.3 6000.6 795.0 877.5 884.6 953.2 987.1 3742.4 3830.5 3831.2 3942.4 4084.8 10782.6 10840.9 10843.0 10851.5 11027.2 10815.2 10815.5 10922.2 10922.7 10959.8 7799.4 8091.2 8174.8 8183.4 8326.0 5836.1 5919.2 5966.8 5978.8 5980.0 10005.2 10066.1 10093.9 10202.8 10226.7 9833.6 10183.8 10254.9 10379.9 10382.7 6972.3 7193.4 7387.6 7420.9 7593.5 8342.1 8388.1 8448.6 8486.0 8521.1 6364.5 7401.9 7564.3 7567.7 7640.0 7281.7 7349.8 7368.0 7382.9 7427.0 6918.4 7005.5 7072.6 7088.7 7210.0 4892.5 4893.5 4914.7 4940.3 4958.2 4104.6 4590.7 4866.6 4905.6 5025.7 22:16:27 INFO - PROCESS | 1958 | 22:16:27 INFO - PROCESS | 1958 | [#4] prototype.html Cycles:180 Average:4437.04 Median:4849.55 stddev:1362.39 (28.1%) stddev-sans-first:1329.73 22:16:27 INFO - PROCESS | 1958 | Values: 264.7 278.7 296.8 310.1 311.8 5029.3 5106.9 5451.8 5482.3 5548.5 4259.1 4525.8 4736.6 5386.8 5517.7 3453.4 3861.3 4019.9 4153.3 4161.1 4029.6 4188.4 4190.8 4196.1 4205.9 3560.2 3825.6 4109.9 4154.2 4177.8 4125.4 4142.1 4166.4 4175.5 4180.6 3589.0 3596.1 3596.8 3613.5 3616.8 5054.7 5243.8 5259.2 5302.7 5320.2 4526.4 4781.7 4799.5 4844.8 4847.4 5016.8 5344.2 5756.9 5778.8 5785.7 3837.9 3936.3 3962.0 3971.9 3972.8 4807.6 5458.2 5552.2 5958.0 6041.6 3349.9 3609.9 4047.3 4058.1 4063.4 3623.0 3778.5 3929.4 4055.9 4134.4 3962.0 4013.3 4684.3 4744.0 4774.0 5140.7 5766.4 5802.3 5828.8 5838.2 1156.6 1247.0 1324.8 1373.6 1378.9 915.5 930.0 941.7 948.2 948.5 4335.4 5292.4 5301.8 5436.5 5536.0 5468.9 5941.6 5966.4 6013.4 6045.7 4990.2 5175.2 5287.4 5300.7 5397.5 2306.3 2311.5 2353.0 2572.0 2613.8 4666.4 4717.4 4851.7 5111.7 5112.2 4665.9 4734.7 4975.2 5009.5 5119.4 4455.7 4483.4 4873.0 5080.5 5095.5 4043.0 4440.5 4967.0 4972.9 4975.3 4427.8 4547.8 4830.7 4879.3 4936.5 4701.8 5070.6 5076.0 5085.6 5117.3 3495.7 3507.7 3509.8 3584.3 3592.7 4073.0 4444.3 4670.7 4950.6 5556.5 5859.6 5989.3 5992.3 5999.6 6004.2 4578.9 5165.6 5664.5 5827.7 5895.8 5572.9 5656.6 5657.7 5664.1 5715.8 5549.9 5721.4 5842.8 5869.9 5895.8 5089.7 5249.3 5492.8 5750.3 5778.5 22:16:27 INFO - PROCESS | 1958 | 22:16:27 INFO - PROCESS | 1958 | [#5] yui.html Cycles:180 Average:25801.23 Median:22635.66 stddev:42282.33 (186.8%) stddev-sans-first:42358.91 22:16:27 INFO - PROCESS | 1958 | Values: 692.9 703.7 705.2 714.2 715.0 15158.8 15361.2 15692.8 15886.9 15904.2 14355.3 14394.6 14492.9 14517.4 14555.7 840.8 858.0 863.7 865.3 874.0 687.0 704.6 844.6 868.6 878.1 875.4 891.3 897.9 908.3 915.2 908.1 908.6 909.1 911.1 912.2 634.9 647.7 673.7 674.8 675.1 14457.4 14623.6 14669.8 14680.4 14732.9 14325.8 14400.4 14426.6 14477.1 14780.0 11624.0 12005.0 12022.8 12049.4 12394.0 3780.7 3788.5 3823.2 3895.2 3910.7 116649.0 122547.4 123138.0 123179.0 123710.0 10853.2 11062.7 11162.6 11223.7 11325.8 22552.9 22580.2 22601.9 22669.4 22677.1 7423.8 7771.1 7799.8 7827.7 8104.0 4324.8 4466.4 4470.6 4482.0 4648.4 3499.2 3589.6 3601.7 3648.0 3654.3 654.2 667.9 690.9 696.0 696.4 490.8 620.4 629.9 667.6 678.9 9327.1 9456.5 9495.8 9561.6 9656.6 598.2 635.2 656.8 672.3 675.9 4272.7 4660.3 4663.7 4665.0 4666.6 96111.5 113623.0 165505.0 168940.0 169422.0 114246.9 119458.0 141765.0 145311.0 150001.0 121870.4 122637.0 124373.4 125123.0 127737.4 8682.5 8924.2 9042.6 9048.4 9211.6 54204.0 67529.7 68269.7 68778.0 69033.0 98680.0 104764.0 104775.5 105025.5 106971.5 10948.9 11578.7 11723.3 12042.7 12051.8 12135.8 12653.5 12687.9 13014.5 13308.5 10674.7 11687.4 12104.7 12301.7 12572.1 12179.5 12200.8 12207.4 12483.4 12736.9 11850.4 12065.2 12103.3 12115.9 12356.5 10033.4 10237.9 10237.9 10741.9 10771.6 10392.4 10440.6 10553.2 10585.4 10629.6 22:16:27 INFO - PROCESS | 1958 | -------- Summary: end -------- 22:16:27 INFO - PROCESS | 1958 | 22:16:28 INFO - TEST-INFO | 1958: exit 0 22:16:28 INFO - TEST-OK | dromaeo_css | took 1113982ms 22:16:28 INFO - TEST-START | kraken 22:16:28 INFO - operating with platform_type : mac_ 22:16:28 INFO - Initialising browser for kraken test... 22:16:28 INFO - TEST-INFO | started process 1962 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/tmpCu6FzR/profile http://localhost:56644/getInfo.html) 22:16:31 INFO - PROCESS | 1962 | __metrics Screen width/height:1600/1200 22:16:31 INFO - PROCESS | 1962 | colorDepth:24 22:16:31 INFO - PROCESS | 1962 | Browser inner width/height: 1024/689 22:16:31 INFO - PROCESS | 1962 | __metrics 22:16:31 ERROR - PROCESS | 1962 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 22:16:32 INFO - TEST-INFO | 1962: exit 0 22:16:32 INFO - Browser initialized. 22:16:32 INFO - Running cycle 1/1 for kraken test... 22:16:32 INFO - TEST-INFO | started process 1964 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/tmpCu6FzR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:16:44 INFO - PROCESS | 1964 | RSS: Main: 225562624 22:16:44 INFO - PROCESS | 1964 | 22:16:47 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:56644/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56644/tests/kraken/driver.html?testName=audio-beat-detection) 22:16:48 INFO - PROCESS | 1964 | RSS: Main: 238313472 22:16:48 INFO - PROCESS | 1964 | 22:16:50 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:56644/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56644/tests/kraken/driver.html?testName=audio-dft) 22:16:51 INFO - PROCESS | 1964 | RSS: Main: 245653504 22:16:51 INFO - PROCESS | 1964 | 22:16:54 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:56644/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56644/tests/kraken/driver.html?testName=audio-fft) 22:16:55 INFO - PROCESS | 1964 | RSS: Main: 249499648 22:16:55 INFO - PROCESS | 1964 | 22:16:57 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:56644/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56644/tests/kraken/driver.html?testName=audio-oscillator) 22:16:57 INFO - PROCESS | 1964 | RSS: Main: 249647104 22:16:57 INFO - PROCESS | 1964 | 22:16:59 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:56644/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56644/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:17:00 INFO - PROCESS | 1964 | RSS: Main: 251064320 22:17:00 INFO - PROCESS | 1964 | 22:17:03 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:56644/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56644/tests/kraken/driver.html?testName=imaging-darkroom) 22:17:04 INFO - PROCESS | 1964 | RSS: Main: 252022784 22:17:04 INFO - PROCESS | 1964 | 22:17:06 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:56644/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56644/tests/kraken/driver.html?testName=imaging-desaturate) 22:17:07 INFO - PROCESS | 1964 | RSS: Main: 251805696 22:17:07 INFO - PROCESS | 1964 | 22:17:10 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:56644/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56644/tests/kraken/driver.html?testName=json-parse-financial) 22:17:11 INFO - PROCESS | 1964 | RSS: Main: 252170240 22:17:11 INFO - PROCESS | 1964 | 22:17:12 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:56644/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56644/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:17:13 INFO - PROCESS | 1964 | RSS: Main: 252010496 22:17:13 INFO - PROCESS | 1964 | 22:17:15 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:56644/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56644/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:17:15 INFO - PROCESS | 1964 | RSS: Main: 252342272 22:17:15 INFO - PROCESS | 1964 | 22:17:18 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:56644/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56644/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:17:18 INFO - PROCESS | 1964 | RSS: Main: 252137472 22:17:18 INFO - PROCESS | 1964 | 22:17:21 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:56644/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56644/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:17:22 INFO - PROCESS | 1964 | RSS: Main: 252092416 22:17:22 INFO - PROCESS | 1964 | 22:17:25 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:56644/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56644/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:17:26 INFO - PROCESS | 1964 | RSS: Main: 252493824 22:17:26 INFO - PROCESS | 1964 | 22:17:28 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:56644/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56644/tests/kraken/driver.html?testName=ai-astar) 22:17:28 INFO - PROCESS | 1964 | RSS: Main: 254169088 22:17:28 INFO - PROCESS | 1964 | 22:17:28 INFO - PROCESS | 1964 | __start_tp_report 22:17:28 INFO - PROCESS | 1964 | _x_x_mozilla_page_load 22:17:28 INFO - PROCESS | 1964 | _x_x_mozilla_page_load_details 22:17:28 INFO - PROCESS | 1964 | |i|pagename|runs| 22:17:28 INFO - PROCESS | 1964 | |0;ai-astar;116;120;121;120;118;120;115;119;118;141 22:17:28 INFO - PROCESS | 1964 | |1;audio-beat-detection;146;111;110;143;112;113;110;111;137;110 22:17:28 INFO - PROCESS | 1964 | |2;audio-dft;226;248;195;198;199;202;197;201;201;199 22:17:28 INFO - PROCESS | 1964 | |3;audio-fft;86;58;59;87;64;87;86;65;77;59 22:17:28 INFO - PROCESS | 1964 | |4;audio-oscillator;91;71;91;72;72;72;74;91;93;118 22:17:28 INFO - PROCESS | 1964 | |5;imaging-gaussian-blur;137;131;89;87;87;87;91;87;90;87 22:17:28 INFO - PROCESS | 1964 | |6;imaging-darkroom;98;100;99;100;100;100;100;101;99;99 22:17:28 INFO - PROCESS | 1964 | |7;imaging-desaturate;92;95;91;101;92;91;91;95;93;91 22:17:28 INFO - PROCESS | 1964 | |8;json-parse-financial;56;55;56;58;90;86;59;59;57;58 22:17:28 INFO - PROCESS | 1964 | |9;json-stringify-tinderbox;71;83;95;96;76;77;74;71;71;71 22:17:28 INFO - PROCESS | 1964 | |10;stanford-crypto-aes;87;106;106;79;85;85;72;83;73;99 22:17:28 INFO - PROCESS | 1964 | |11;stanford-crypto-ccm;135;158;163;127;161;146;156;159;186;165 22:17:28 INFO - PROCESS | 1964 | |12;stanford-crypto-pbkdf2;143;208;179;167;203;240;198;191;173;230 22:17:28 INFO - PROCESS | 1964 | |13;stanford-crypto-sha256-iterative;68;66;86;72;68;69;66;67;65;68 22:17:28 INFO - PROCESS | 1964 | __end_tp_report 22:17:28 INFO - PROCESS | 1964 | __start_cc_report 22:17:28 INFO - PROCESS | 1964 | _x_x_mozilla_cycle_collect,965 22:17:28 INFO - PROCESS | 1964 | __end_cc_report 22:17:28 INFO - PROCESS | 1964 | __startTimestamp1479017848371__endTimestamp 22:17:28 INFO - PROCESS | 1964 | 22:17:28 INFO - PROCESS | 1964 | ------- Summary: start ------- 22:17:28 INFO - PROCESS | 1964 | Number of tests: 14 22:17:28 INFO - PROCESS | 1964 | 22:17:28 INFO - PROCESS | 1964 | [#0] ai-astar Cycles:10 Average:120.80 Median:120.00 stddev:7.35 (6.1%) stddev-sans-first:7.58 22:17:28 INFO - PROCESS | 1964 | Values: 116.0 120.0 121.0 120.0 118.0 120.0 115.0 119.0 118.0 141.0 22:17:28 INFO - PROCESS | 1964 | 22:17:28 INFO - PROCESS | 1964 | [#1] audio-beat-detection Cycles:10 Average:120.30 Median:112.50 stddev:15.16 (13.5%) stddev-sans-first:12.91 22:17:28 INFO - PROCESS | 1964 | Values: 146.0 111.0 110.0 143.0 112.0 113.0 110.0 111.0 137.0 110.0 22:17:28 INFO - PROCESS | 1964 | 22:17:28 INFO - PROCESS | 1964 | [#2] audio-dft Cycles:10 Average:206.60 Median:201.00 stddev:16.97 (8.4%) stddev-sans-first:16.48 22:17:28 INFO - PROCESS | 1964 | Values: 226.0 248.0 195.0 198.0 199.0 202.0 197.0 201.0 201.0 199.0 22:17:28 INFO - PROCESS | 1964 | 22:17:28 INFO - PROCESS | 1964 | [#3] audio-fft Cycles:10 Average:72.80 Median:81.50 stddev:12.94 (15.9%) stddev-sans-first:12.82 22:17:28 INFO - PROCESS | 1964 | Values: 86.0 58.0 59.0 87.0 64.0 87.0 86.0 65.0 77.0 59.0 22:17:28 INFO - PROCESS | 1964 | 22:17:28 INFO - PROCESS | 1964 | [#4] audio-oscillator Cycles:10 Average:84.50 Median:82.50 stddev:15.21 (18.4%) stddev-sans-first:15.95 22:17:28 INFO - PROCESS | 1964 | Values: 91.0 71.0 91.0 72.0 72.0 72.0 74.0 91.0 93.0 118.0 22:17:28 INFO - PROCESS | 1964 | 22:17:28 INFO - PROCESS | 1964 | [#5] imaging-gaussian-blur Cycles:10 Average:97.30 Median:87.00 stddev:19.45 (22.4%) stddev-sans-first:14.37 22:17:28 INFO - PROCESS | 1964 | Values: 137.0 131.0 89.0 87.0 87.0 87.0 91.0 87.0 90.0 87.0 22:17:28 INFO - PROCESS | 1964 | 22:17:28 INFO - PROCESS | 1964 | [#6] imaging-darkroom Cycles:10 Average:99.60 Median:99.50 stddev:0.84 (0.8%) stddev-sans-first:0.67 22:17:28 INFO - PROCESS | 1964 | Values: 98.0 100.0 99.0 100.0 100.0 100.0 100.0 101.0 99.0 99.0 22:17:28 INFO - PROCESS | 1964 | 22:17:28 INFO - PROCESS | 1964 | [#7] imaging-desaturate Cycles:10 Average:93.20 Median:92.00 stddev:3.16 (3.4%) stddev-sans-first:3.32 22:17:28 INFO - PROCESS | 1964 | Values: 92.0 95.0 91.0 101.0 92.0 91.0 91.0 95.0 93.0 91.0 22:17:28 INFO - PROCESS | 1964 | 22:17:28 INFO - PROCESS | 1964 | [#8] json-parse-financial Cycles:10 Average:63.40 Median:58.50 stddev:13.07 (22.3%) stddev-sans-first:13.58 22:17:28 INFO - PROCESS | 1964 | Values: 56.0 55.0 56.0 58.0 90.0 86.0 59.0 59.0 57.0 58.0 22:17:28 INFO - PROCESS | 1964 | 22:17:28 INFO - PROCESS | 1964 | [#9] json-stringify-tinderbox Cycles:10 Average:78.50 Median:76.50 stddev:9.73 (12.7%) stddev-sans-first:9.94 22:17:28 INFO - PROCESS | 1964 | Values: 71.0 83.0 95.0 96.0 76.0 77.0 74.0 71.0 71.0 71.0 22:17:28 INFO - PROCESS | 1964 | 22:17:28 INFO - PROCESS | 1964 | [#10] stanford-crypto-aes Cycles:10 Average:87.50 Median:84.00 stddev:12.35 (14.7%) stddev-sans-first:13.10 22:17:28 INFO - PROCESS | 1964 | Values: 87.0 106.0 106.0 79.0 85.0 85.0 72.0 83.0 73.0 99.0 22:17:28 INFO - PROCESS | 1964 | 22:17:28 INFO - PROCESS | 1964 | [#11] stanford-crypto-ccm Cycles:10 Average:155.60 Median:160.00 stddev:16.49 (10.3%) stddev-sans-first:15.72 22:17:28 INFO - PROCESS | 1964 | Values: 135.0 158.0 163.0 127.0 161.0 146.0 156.0 159.0 186.0 165.0 22:17:28 INFO - PROCESS | 1964 | 22:17:28 INFO - PROCESS | 1964 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:193.20 Median:200.50 stddev:29.26 (14.6%) stddev-sans-first:24.76 22:17:28 INFO - PROCESS | 1964 | Values: 143.0 208.0 179.0 167.0 203.0 240.0 198.0 191.0 173.0 230.0 22:17:28 INFO - PROCESS | 1964 | 22:17:28 INFO - PROCESS | 1964 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.50 Median:68.00 stddev:6.11 (9.0%) stddev-sans-first:6.46 22:17:28 INFO - PROCESS | 1964 | Values: 68.0 66.0 86.0 72.0 68.0 69.0 66.0 67.0 65.0 68.0 22:17:28 INFO - PROCESS | 1964 | -------- Summary: end -------- 22:17:28 INFO - PROCESS | 1964 | 22:17:29 INFO - TEST-INFO | 1964: exit 0 22:17:29 INFO - TEST-OK | kraken | took 60718ms 22:17:29 INFO - SUITE-END | took 1174s 22:17:29 INFO - Completed test suite (00:19:34) 22:17:29 INFO - javascript benchmark 22:17:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7302.613025706853, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3390.1524618845306, 3393.3213357328536, 3407.1141503209165, 3419.1281223288056, 3439.2605589798204, 5733.856653583663, 5762.481376676098, 5780.161876527901, 5780.710964451776, 5790.623609465381, 5793.33376661684, 5842.532597392209, 5866.120081987693, 5883.676397798119, 5922.466977971982, 5266.578673706094, 5344.7862085516535, 5353.197020446925, 5355.732213389334, 5356.9732151339385, 5366.221897824813, 5373.785048598052, 5393.838184854441, 5400.756965936543, 5439.0209762242785, 5252.579793616521, 5258.763355649005, 5351.7056561889085, 5365.302510673607, 5370.0, 4309.504406993205, 4376.431063961696, 5271.604629652772, 5283.154695248761, 5297.867553311159, 5219.895602087975, 5261.552768014723, 5280.551153151987, 5316.787328506855, 5380.515753582157, 4548.2495388260895, 4660.510646382115, 5709.286339207599, 5845.473907348359, 5937.228160339128, 5126.974365128188, 6184.041473571604, 6297.244330680302, 6299.811005669837, 6316.526260530479, 6228.128062071269, 6279.837683004441, 6290.087937249119, 6291.245050593912, 6301.905471417932, 5730.828075157752, 5780.971095144498, 5847.619904706181, 5945.31628862682, 5953.434423729782, 6242.75028998844, 6306.936930630727, 6345.873082538324, 6355.904661430082, 6368.267649220399, 6228.314885362606, 6245.0632405139595, 6250.531210159256, 6259.3427690091885, 6270.2789179244055, 6142.897836592581, 6157.661328626879, 6316.684165791692, 6319.526035547352, 6331.525135614847, 6170.475509581646, 6215.471684906744, 6243.469305109116, 6250.062490626351, 6281.246250449975, 6238.376162383725, 6248.5313601480075, 6297.118403423525, 6321.083442900754, 6323.083152942798, 4840.467548569725, 4962.5533701967, 4969.527894849984, 4975.253711943165, 4988.5260900214425, 4425.911481770347, 4426.667999900021, 4442.73343599385, 4456.24243878535, 4514.390557274792, 5883.94116058834, 5969.641821490724, 5971.492423144082, 5974.4324289192455, 5992.520598352121, 6178.135061091451, 6203.534734894901, 6279.811605651837, 6295.433410992941, 6301.7164227609865, 5889.528837692974, 5951.5238780897425, 5973.940260597426, 6012.977793775069, 6051.273847138372, 5446.482584154499, 5447.12845944647, 5472.945270547323, 5473.480019398151, 5480.534154596824, 6166.321704612579, 6346.4605508532295, 6353.396427339396, 6353.5870168438905, 6371.490280777527, 6204.441600255998, 6229.719662615103, 6233.937660623335, 6261.7182226799, 6301.7164227608955, 6285.779997700059, 6291.993281075189, 6296.653684047421, 6317.778877739257, 6324.620522768649, 6189.381061893775, 6199.3490683477585, 6199.473044791243, 6205.596636218631, 6208.689565521796, 6121.8493044937295, 6163.568550201622, 6190.0714892764645, 6203.100550420254, 6226.470749986302, 6196.411340922605, 6196.721147548281, 6200.844978875564, 6208.565400422108, 6215.0, 6159.014557670751, 6161.229846269216, 6186.257649082139, 6198.0, 6213.2233470816145, 5802.47777700009, 5861.0, 6017.939820601738, 6048.4858787003595, 6057.848553786191, 6177.382261773787, 6186.721597528032, 6212.06818977157, 6230.906536401867, 6233.189685340877, 5030.320906677698, 6065.423784740619, 6084.300305464928, 6087.69561521931, 6093.299270583762], "value": 5742.200780835363, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [495.3510900720057, 499.8675351031976, 509.4803300633353, 514.5240652396537, 527.0591993291974, 38748.22503549931, 40503.0, 40650.186996260054, 40657.39013914794, 40703.185936281254, 41960.790196048976, 42355.36466952998, 42449.7877510612, 42588.36117458241, 42598.574014259924, 9886.999999999982, 10061.094501494865, 10091.192704583653, 10091.29360944734, 10187.694369168938, 9924.0, 10013.59945602175, 10017.348872323311, 10020.498975051254, 10024.198064154887, 10003.199744020461, 10027.699169024905, 10033.448160351178, 10039.698809035704, 10066.29535932485, 9939.652112176076, 9990.150837178848, 10000.099991000772, 10005.699829005105, 10019.699409017741, 9837.213022958145, 9842.163416109639, 9844.212463003014, 9889.75275618108, 9952.90047099527, 40094.198116037514, 40253.39619905704, 40365.394519082234, 40388.0, 40497.79751101255, 3015.9698403016127, 3129.4836352001894, 3277.3117645294515, 3760.304343696425, 3782.6973842092566, 29263.2684182895, 30220.546691799642, 30505.0, 30623.846880765675, 31052.8447357764, 3106.3942531206426, 3152.290734584723, 3210.96789032109, 3247.0908145719236, 3271.2312606537444, 513303.0, 514888.0, 515645.0, 518161.9999999962, 518512.0, 56778.716106419204, 56890.14664780031, 56934.71532642393, 57192.142117868265, 57495.712521437126, 34081.48877766835, 34273.82863085669, 34567.82716086454, 36032.45951310732, 59322.110168347506, 16777.07726075053, 16998.83001169997, 17020.57448563771, 17022.893511921684, 17046.57383565396, 12824.166429182073, 12907.548235811702, 13005.674858128623, 13036.087473876738, 13043.739125217633, 18850.0, 18856.811431885504, 18880.905595471933, 18889.0, 18920.33778817735, 7852.214778522102, 7966.9601651992525, 7969.800754981055, 8030.839383212303, 8045.316148127475, 826.3719573124469, 865.7446053414258, 945.2768631996528, 968.6173961285253, 974.8001659659752, 28777.42445151085, 30331.241718957204, 30389.544156837666, 30705.078847634606, 30800.691993080232, 1001.159026417798, 1052.6368402900987, 1069.812782763029, 1120.8710998235144, 1131.6491887514896, 15545.689086218212, 15759.212039397984, 15770.921145394199, 15794.0, 16025.919870400807, 589615.0, 689362.5531872308, 697795.0, 703270.4836475888, 704581.0, 57410.42589574134, 57422.425775742544, 57761.422385776445, 58037.0, 58111.41888581144, 1346.912450690702, 1348.4134401535364, 1351.175782772508, 1355.2410650036209, 1380.1029330934973, 24433.0, 29416.26459338534, 29868.0, 30024.0, 30494.84752576223, 48564.51435485741, 48708.5129148704, 49173.0, 49173.26240106473, 49257.0, 636415.0, 645754.0, 646020.0, 646416.0, 647165.0, 42683.0, 42704.78647606742, 43204.56795432005, 43406.56593434025, 43407.612581308334, 40688.79655601703, 45038.324425134306, 46256.07487850157, 46858.531414685414, 47135.764321178176, 28551.0, 31602.0, 33604.83197584094, 38275.66035188755, 38839.41740873833, 31388.0, 38565.22869542537, 38586.22827543489, 39498.40752388659, 39771.40342894917, 37995.0, 38027.61972380241, 38957.6104238954, 39017.0, 40155.59844401519, 31267.84366078155, 31647.36705265928, 34783.304333913686, 35210.0, 35286.647133528335, 25810.87094564515, 25846.22461326163, 25884.35289117787, 26275.73724262733, 26351.73648263493], "value": 20124.826073128133, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.15893557367065, 378.18123762055154, 383.98656047038327, 384.4982298100978, 401.85131501344506, 19021.144048517814, 20137.395878123643, 21080.472988175305, 21421.357359279227, 21506.462338441506, 11551.018163456096, 12075.2151110178, 12102.0, 12135.635930922064, 18112.094395280248, 5228.137357336035, 5511.311086114236, 5514.779408823642, 5518.724063796814, 5522.282103326582, 5270.657407268515, 5388.78444862205, 5464.808731694391, 5469.972650136764, 5504.64219825712, 5337.813176538822, 5367.570594352443, 5450.264214331074, 5459.099248623972, 5479.150731636582, 4775.522447755214, 5355.732213389315, 6207.099970504251, 6216.844578885519, 6241.594296370721, 5867.765289388462, 6066.272047354301, 6069.02895536712, 6092.329843717188, 6097.390260973912, 13008.544700935421, 13185.406656700472, 13248.205107693473, 13324.400401981935, 13326.0, 2117.2589593642256, 2255.763144869798, 2592.792576593868, 2884.6538415390078, 2946.0572616762643, 9766.658166964122, 9856.704298871045, 9948.751281217956, 10368.844467332996, 10408.687739367831, 1659.9751003734953, 1820.0, 1822.9270829166817, 1855.9072046397625, 1957.9021048947495, 118216.8178318223, 118862.40568797187, 126311.36844315812, 127614.0, 129500.0, 11601.361925094201, 11731.002864756421, 11741.706457338463, 12028.458719357475, 12091.45588448522, 14758.704825903422, 14802.777958330633, 14803.0, 14822.481213157704, 14857.108573485626, 8204.83590328202, 8296.668133274723, 8586.356023298278, 8785.945686517658, 8804.647814087364, 8517.190866867637, 8602.655893764178, 8636.654533818702, 8791.681247812752, 8865.867011994826, 4479.731216127043, 4571.862844114682, 4611.400517932647, 4617.820872110745, 4628.4445866496235, 1909.9331523396615, 1950.9414717558495, 1952.2971730177126, 1959.4023822734202, 1960.2453055573708, 775.573434610973, 816.1185919207361, 830.7839961610025, 839.2195258409615, 913.7395842185078, 15466.304016319293, 17154.0, 17368.78418510692, 21146.78853211479, 21156.78843211548, 883.6332921837366, 887.671561522241, 917.729269865378, 988.8615593816871, 1020.9030142136485, 10621.5220315086, 11241.437928103562, 11278.210525263317, 11278.943605282086, 11302.547898083985, 578364.0, 586544.0, 596153.0, 602210.0, 604037.0, 72746.27253727501, 126931.0, 131274.0, 133433.0, 134357.0, 942.1097063275276, 950.396498223633, 979.8383266761048, 980.8773903262093, 984.2814745235875, 18833.529161771065, 19076.713849291995, 19539.804601953798, 19744.40766776999, 19787.802121978595, 54493.0, 55504.72247638736, 56591.01931432545, 57767.71116144393, 58303.4169658298, 79102.6044869772, 80711.0, 82270.58864705877, 84211.0, 86355.70466443134, 7969.6015199238645, 8123.18768123183, 8139.267465928095, 8370.66517339324, 8389.993200815941, 11215.887841121485, 12390.504379824706, 12492.063095268073, 12751.681207969876, 12781.04142189321, 10699.358038517714, 10825.458727063458, 10953.068989135694, 10956.233063685466, 11151.944240278746, 9132.908670913472, 10747.247692661438, 10820.350778953289, 10994.34033957965, 11133.610323638957, 9462.817147856518, 10625.25623206399, 11141.164412669244, 11234.55061797519, 11441.199116061796, 6101.633901965896, 7772.650230739743, 7969.561674107979, 8001.359891208573, 8159.755207343789, 8627.266682332072, 10954.287971281841, 10971.341719496855, 11184.944075279896, 11288.717782055513], "value": 9218.741751028567, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1501.0768377447866, 1529.5411376587024, 1600.8559229669327, 1743.9361989186593, 1840.8987505687198, 7994.280514753671, 8243.052049014364, 8478.788030299238, 9070.818583628332, 9101.90898091019, 8584.48493090415, 8842.381033327654, 8855.95572022139, 8973.416727912698, 8988.640454381833, 2357.4342157882115, 2372.134171027571, 2407.9277621671376, 2410.5901996660523, 2411.493586346869, 2021.8281446077028, 2407.193590147294, 2414.4326083370393, 2419.068658566447, 2422.0432928993037, 2393.533261014103, 2399.5800734871414, 2409.132712223598, 2416.178499310234, 2418.733939266679, 2170.8060566688414, 2173.271953895431, 2365.3377054424705, 2373.774491423312, 2394.365493144318, 2013.7382140321665, 2359.00921612923, 2384.3443053160345, 2387.164492427654, 2389.462370966536, 8872.11278872114, 8925.152110549487, 8944.284457243404, 8950.149735775156, 8962.775930601721, 4830.806767729287, 5179.249008893727, 5343.412224655323, 5422.593305502063, 5426.403095659474, 3141.780075394723, 3508.1405055761247, 3519.9120021999656, 3653.488511608377, 3682.9447558286647, 1040.2146379483518, 1055.5672174408533, 1072.0405237312561, 1076.2412499188054, 1081.3133660125798, 11671.474783634756, 11708.238964467282, 11727.472263748152, 11739.530418783324, 11834.881651183465, 4608.631309495232, 4727.314539391769, 4815.975920120377, 4854.199057155601, 4879.926801097987, 9978.750531236632, 10079.647212347532, 10088.344257623232, 10089.596416143419, 10094.596216151418, 5411.107167317348, 5411.729413529387, 5414.242006119146, 5416.864578385572, 5426.782928682808, 4352.956470435319, 4520.073384956077, 4780.115678599401, 4911.361523002059, 4941.950580494149, 3558.484019817112, 3984.143409167043, 4008.3386241269864, 4082.5302890959233, 4138.461999939988, 1277.8083287506947, 1311.4426368793415, 1314.7764879970428, 1322.5238913990956, 1324.5628942448968, 737.0749709115026, 782.5226611766818, 820.4789958376355, 857.9914200858036, 872.4067634008808, 5524.839783645399, 5642.605017648725, 5689.544836413077, 5775.306963164448, 6000.639961602318, 794.9761507154794, 877.4954401219325, 884.5975081337975, 953.1850268020881, 987.0820137272406, 3742.3825068863875, 3830.4637350770913, 3831.1762970961377, 3942.3692209246383, 4084.8366065357054, 10782.568697252022, 10840.891591084146, 10843.0, 10851.51168197433, 11027.22809403334, 10815.242932994615, 10815.513301901434, 10922.1808364373, 10922.672319830417, 10959.780804383867, 7799.376049916106, 8091.1504292048485, 8174.7956301092945, 8183.427160098736, 8326.0, 5836.095405212199, 5919.200907877554, 5966.797020576614, 5978.7608495661425, 5980.013297805987, 10005.199584033115, 10066.094051535398, 10093.949530252596, 10202.846957295795, 10226.744331391776, 9833.557489912828, 10183.796324073624, 10254.897451025692, 10379.948100259451, 10382.688519344432, 6972.302769722987, 7193.388561972291, 7387.593682347308, 7420.888686669597, 7593.506422082547, 8342.12407697183, 8388.119247478928, 8448.619812108347, 8485.95757021211, 8521.062683104978, 6364.459020983269, 7401.888971665322, 7564.281393267851, 7567.697292108254, 7640.0, 7281.745138920112, 7349.8162545936775, 7367.963160184165, 7382.926170738224, 7427.034485516848, 6918.377346038881, 7005.474589405713, 7072.575645461289, 7088.716451341888, 7210.0, 4892.535209155125, 4893.461719210955, 4914.729689867092, 4940.308356830118, 4958.206686930074, 4104.630583247522, 4590.747508887043, 4866.586340161126, 4905.632077594123, 5025.723585202702], "value": 4576.626354040534, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [264.7458439897698, 278.72127872127874, 296.7952113042001, 310.09297803923516, 311.8129122526483, 5029.346184995946, 5106.876487172825, 5451.809186678467, 5482.342118945727, 5548.472895074967, 4259.1038094096, 4525.796339164737, 4736.573708366246, 5386.814900721844, 5517.668939863611, 3453.3783918894587, 3861.3049651062797, 4019.9397009044887, 4153.341861208821, 4161.10536234711, 4029.6373326400617, 4188.371744238373, 4190.811413486401, 4196.097838964622, 4205.85279515217, 3560.181158333585, 3825.5791862895057, 4109.9108736184935, 4154.169166166764, 4177.830207541893, 4125.401816736587, 4142.1301526679135, 4166.437530933315, 4175.519815221242, 4180.644645205146, 3589.0, 3596.1009747563107, 3596.820158992066, 3613.5483064616924, 3616.806453870243, 5054.671446355975, 5243.8164664236565, 5259.211118332242, 5302.681839089667, 5320.228566857822, 4526.411566496367, 4781.713097214143, 4799.544043315879, 4844.8304309349005, 4847.3698419205275, 5016.799328026875, 5344.22508736235, 5756.942430575683, 5778.7688492460675, 5785.739641716133, 3837.884863454101, 3936.311145549546, 3962.0, 3971.940420893689, 3972.8149517765114, 4807.591354734816, 5458.235846981426, 5552.222688823608, 5957.970210148921, 6041.6072955258205, 3349.894534803509, 3609.9278014440088, 4047.291723948297, 4058.1477889643506, 4063.4311196432523, 3622.9637703623152, 3778.4899038629983, 3929.44987701722, 4055.91888162241, 4134.421181034658, 3961.959590810735, 4013.337799263147, 4684.344191813149, 4743.960097158255, 4774.0, 5140.665856719302, 5766.4233576642, 5802.274715660543, 5828.766849326064, 5838.241028666331, 1156.6414411532453, 1246.9812952805714, 1324.8079028540808, 1373.6497193215666, 1378.945106993151, 915.4919019943862, 929.9814003720023, 941.6892425499568, 948.1608776232946, 948.5020364308793, 4335.3713711511655, 5292.364916210079, 5301.83359660874, 5436.483534064258, 5535.955224626439, 5468.890622187534, 5941.55438342126, 5966.433188847052, 6013.4064472914715, 6045.697715114226, 4990.151674215392, 5175.197844334134, 5287.446997337511, 5300.681959082467, 5397.541208997201, 2306.285051633999, 2311.549247896644, 2352.9764402613737, 2571.996921200733, 2613.777828884528, 4666.416697912761, 4717.3631559739, 4851.733154676526, 5111.693298402108, 5112.239390728964, 4665.906681866411, 4734.692245004064, 4975.243691013334, 5009.549140577293, 5119.414695578709, 4455.660778091463, 4483.3723278741, 4873.025394920959, 5080.54275115234, 5095.464976177596, 4042.978510744628, 4440.489343725513, 4966.9817687374725, 4972.872515811795, 4975.308395145667, 4427.756473393994, 4547.840825571089, 4830.739251005487, 4879.267859909823, 4936.520462286787, 4701.764911754467, 5070.630929649048, 5075.974620126875, 5085.644004919768, 5117.26013155514, 3495.650434956484, 3507.701845343174, 3509.78941263525, 3584.301061293127, 3592.6766591006935, 4073.0, 4444.311131774451, 4670.696404733681, 4950.554450099508, 5556.472135147154, 5859.589828711949, 5989.341172471112, 5992.310884248367, 5999.550033747573, 6004.249468816398, 4578.908421831478, 5165.638405311592, 5664.461876121762, 5827.708614569339, 5895.764169433346, 5572.93801293524, 5656.575756818337, 5657.660540367591, 5664.0937450007805, 5715.771369145187, 5549.916751248816, 5721.425358588568, 5842.795502157404, 5869.853253668522, 5895.818547137586, 5089.694618322913, 5249.291345668286, 5492.80775172867, 5750.30996280449, 5778.537716982547], "value": 4004.2259713517124, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [692.857964117356, 703.6587255181239, 705.1819888928843, 714.2143641993807, 714.9954314188564, 15158.77261841072, 15361.15513646749, 15692.843071569281, 15886.920565397186, 15904.204789760524, 14355.28223588819, 14394.640133996629, 14492.927535362334, 14517.419303227858, 14555.708885822303, 840.7855996720843, 857.9613917373733, 863.7365603490932, 865.3380164174412, 873.9861760357986, 687.0312858868996, 704.6441547018749, 844.5945945945949, 868.5526953618892, 878.064860923118, 875.4353442029887, 891.2780647675404, 897.8698088777123, 908.2643059122132, 915.1809130827905, 908.1372695938851, 908.6274627402734, 909.0818273543769, 911.0707078779608, 912.2291663544295, 634.8571571396445, 647.744141064277, 673.7305077968851, 674.7570874485182, 675.1122274209399, 14457.421703131862, 14623.63440913975, 14669.77995330071, 14680.412783488648, 14732.926335368255, 14325.78511322331, 14400.423983040666, 14426.639334016629, 14477.05899116554, 14780.0, 11623.953844154066, 12005.039596832232, 12022.819657705142, 12049.397530123459, 12394.0, 3780.6786423154067, 3788.488554045196, 3823.216240670684, 3895.1625400538737, 3910.706696997708, 116649.0, 122547.38726306401, 123138.0, 123179.0, 123710.0, 10853.24027318096, 11062.668119956414, 11162.553497859995, 11223.71940701489, 11325.773484530264, 22552.872356382115, 22580.20969266068, 22601.88699056494, 22669.43326416853, 22677.092916283495, 7423.777286681408, 7771.067471903408, 7799.8300254962205, 7827.726029588937, 8104.027516697916, 4324.783760811947, 4466.3747075409465, 4470.575295346936, 4482.0, 4648.372469716545, 3499.2126771476724, 3589.5692516897616, 3601.7118630509494, 3648.0332711831384, 3654.30568192048, 654.1953397321226, 667.8764428580728, 690.8618276344752, 695.9686814093378, 696.3837004251274, 490.7521701540699, 620.4137090449572, 629.9181106456132, 667.5560752099897, 678.9321067893171, 9327.067293270618, 9456.52717364129, 9495.762605934908, 9561.61753529865, 9656.565454554422, 598.2014011294883, 635.2250254689365, 656.7701304543467, 672.2806596941226, 675.8614484030762, 4272.7222730523035, 4660.300954856799, 4663.673542852036, 4664.953350466452, 4666.580007799314, 96111.51944240234, 113623.0, 165505.0, 168940.0, 169422.0, 114246.85753142528, 119458.0, 141765.0, 145311.0, 150001.0, 121870.39064804619, 122637.0, 124373.37813310875, 125123.0, 127737.36131319284, 8682.479051256945, 8924.196822286025, 9042.593083311136, 9048.366614336934, 9211.585478653342, 54204.0, 67529.6623516899, 68269.65865170643, 68778.0, 69032.96450553145, 98680.0, 104764.0, 104775.4761226189, 105025.47487262514, 106971.46514267378, 10948.890511095105, 11578.652640420802, 11723.296602203895, 12042.698932526757, 12051.75896482048, 12135.757284854077, 12653.493860245488, 12687.873121269038, 13014.489292254118, 13308.467661293827, 10674.679759607225, 11687.415629218674, 12104.697382565506, 12301.692457688629, 12572.057095717675, 12179.512819487476, 12200.75598488043, 12207.389630518615, 12483.438245279165, 12736.936315318364, 11850.392525596264, 12065.215760975509, 12103.33431661267, 12115.878841211475, 12356.505739770668, 10033.397996120257, 10237.897621023694, 10237.9488102559, 10741.872103429027, 10771.6229931952, 10392.42841643717, 10440.58237670515, 10553.155747540332, 10585.364878107339, 10629.627963021258], "value": 7767.41989053464, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1542.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 120.0, 121.0, 120.0, 118.0, 120.0, 115.0, 119.0, 118.0, 141.0], "value": 120.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 111.0, 110.0, 143.0, 112.0, 113.0, 110.0, 111.0, 137.0, 110.0], "value": 120.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [226.0, 248.0, 195.0, 198.0, 199.0, 202.0, 197.0, 201.0, 201.0, 199.0], "value": 206.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 58.0, 59.0, 87.0, 64.0, 87.0, 86.0, 65.0, 77.0, 59.0], "value": 72.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 71.0, 91.0, 72.0, 72.0, 72.0, 74.0, 91.0, 93.0, 118.0], "value": 84.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 131.0, 89.0, 87.0, 87.0, 87.0, 91.0, 87.0, 90.0, 87.0], "value": 97.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 100.0, 99.0, 100.0, 100.0, 100.0, 100.0, 101.0, 99.0, 99.0], "value": 99.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 95.0, 91.0, 101.0, 92.0, 91.0, 91.0, 95.0, 93.0, 91.0], "value": 93.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 56.0, 58.0, 90.0, 86.0, 59.0, 59.0, 57.0, 58.0], "value": 63.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 83.0, 95.0, 96.0, 76.0, 77.0, 74.0, 71.0, 71.0, 71.0], "value": 78.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 106.0, 106.0, 79.0, 85.0, 85.0, 72.0, 83.0, 73.0, 99.0], "value": 87.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 158.0, 163.0, 127.0, 161.0, 146.0, 156.0, 159.0, 186.0, 165.0], "value": 155.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 208.0, 179.0, 167.0, 203.0, 240.0, 198.0, 191.0, 173.0, 230.0], "value": 193.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 86.0, 72.0, 68.0, 69.0, 66.0, 67.0, 65.0, 68.0], "value": 69.5, "unit": "score"}]}]} 22:17:29 INFO - Return code: 0 22:17:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:17:29 ERROR - # TBPL SUCCESS # 22:17:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:17:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:17:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:17:29 INFO - 2016-11-12 22:17:29.706 screenresolution[1969:23428] starting screenresolution argv=screenresolution get 22:17:29 INFO - 2016-11-12 22:17:29.708 screenresolution[1969:23428] Display 0: 1600x1200x32@60 22:17:29 INFO - 2016-11-12 22:17:29.715 screenresolution[1970:23431] starting screenresolution argv=screenresolution list 22:17:29 INFO - Available Modes on Display 0 22:17:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:17:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:17:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:17:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:17:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:17:29 INFO - Intel Iris: 22:17:29 INFO - Chipset Model: Intel Iris 22:17:29 INFO - Type: GPU 22:17:29 INFO - Bus: Built-In 22:17:29 INFO - VRAM (Dynamic, Max): 1536 MB 22:17:29 INFO - Vendor: Intel (0x8086) 22:17:29 INFO - Device ID: 0x0a2e 22:17:29 INFO - Revision ID: 0x0009 22:17:29 INFO - Displays: 22:17:29 INFO - Display: 22:17:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:17:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:17:29 INFO - Display Serial Number: 1600x1200 60 22:17:29 INFO - Main Display: Yes 22:17:29 INFO - Mirror: Off 22:17:29 INFO - Online: Yes 22:17:29 INFO - Rotation: Supported 22:17:29 INFO - Return code: 0 22:17:29 INFO - Running post-action listener: _resource_record_post_action 22:17:29 INFO - [mozharness: 2016-11-13 06:17:29.947989Z] Finished run-tests step (success) 22:17:29 INFO - Running post-run listener: _resource_record_post_run 22:17:30 INFO - Total resource usage - Wall time: 1207s; CPU: 54.0%; Read bytes: 991232; Write bytes: 664798208; Read time: 7; Write time: 1899 22:17:30 INFO - TinderboxPrint: CPU usage
54.4% 22:17:30 INFO - TinderboxPrint: I/O read bytes / time
991,232 / 7 22:17:30 INFO - TinderboxPrint: I/O write bytes / time
664,798,208 / 1,899 22:17:30 INFO - TinderboxPrint: CPU idle
2,204.7 (45.6%) 22:17:30 INFO - TinderboxPrint: CPU system
977.7 (20.2%) 22:17:30 INFO - TinderboxPrint: CPU user
1,647.3 (34.1%) 22:17:30 INFO - TinderboxPrint: Swap in / out
363,929,600 / 0 22:17:30 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 358625792; Write bytes: 357025280; Read time: 27519; Write time: 689 22:17:30 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 155648; Write bytes: 296709632; Read time: 3; Write time: 1178 22:17:30 INFO - Running post-run listener: _upload_blobber_files 22:17:30 INFO - Blob upload gear active. 22:17:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:17:30 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 22:17:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:17:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:17:30 INFO - (blobuploader) - INFO - Open directory for files ... 22:17:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:17:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:17:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:17:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:17:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:17:31 INFO - (blobuploader) - INFO - Done attempting. 22:17:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:17:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:17:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:17:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:17:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:17:32 INFO - (blobuploader) - INFO - Done attempting. 22:17:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:17:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:17:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:17:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:17:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:17:35 INFO - (blobuploader) - INFO - Done attempting. 22:17:35 INFO - (blobuploader) - INFO - Iteration through files over. 22:17:35 INFO - Return code: 0 22:17:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:17:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:17:35 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b8f86b659450045c7884c84d6db552ebda42b9e77952f160554177e83d526724b7a40a67ab6c874577cf30f8b54c38f2a838ee6a0b06e82054b303fee56608dc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ff781cdf4ccbf05b682e7a84929288a835421501b376359aeb83c28bfa9bdab030094705d8d5df2711c26910a5520d9edb37c89c1b39da6285417572bcc6bf15", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c43c10399c2dde7a7a1105e9a5148ecf98cf78c0b7ef32cae0ac30116c824ee0da3c213de02a2510709b895332a3b302eaf463ec1be65f7e68f15df00c584783"} 22:17:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:17:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:17:35 INFO - Contents: 22:17:35 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b8f86b659450045c7884c84d6db552ebda42b9e77952f160554177e83d526724b7a40a67ab6c874577cf30f8b54c38f2a838ee6a0b06e82054b303fee56608dc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ff781cdf4ccbf05b682e7a84929288a835421501b376359aeb83c28bfa9bdab030094705d8d5df2711c26910a5520d9edb37c89c1b39da6285417572bcc6bf15", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c43c10399c2dde7a7a1105e9a5148ecf98cf78c0b7ef32cae0ac30116c824ee0da3c213de02a2510709b895332a3b302eaf463ec1be65f7e68f15df00c584783"} 22:17:35 INFO - Running post-run listener: copy_logs_to_upload_dir 22:17:35 INFO - Copying logs to upload dir... 22:17:35 INFO - mkdir: /builds/slave/test/build/upload/logs 22:17:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.705661 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-11-12 22:17:35.347302) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-12 22:17:35.355262) ========= 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.tAESFzYuwF/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.W7BCjvV5ct/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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/b8f86b659450045c7884c84d6db552ebda42b9e77952f160554177e83d526724b7a40a67ab6c874577cf30f8b54c38f2a838ee6a0b06e82054b303fee56608dc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ff781cdf4ccbf05b682e7a84929288a835421501b376359aeb83c28bfa9bdab030094705d8d5df2711c26910a5520d9edb37c89c1b39da6285417572bcc6bf15", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c43c10399c2dde7a7a1105e9a5148ecf98cf78c0b7ef32cae0ac30116c824ee0da3c213de02a2510709b895332a3b302eaf463ec1be65f7e68f15df00c584783"} build_url:https://queue.taskcluster.net/v1/task/Fg527KEhTUS1A0MuetLz4g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010541 build_url: 'https://queue.taskcluster.net/v1/task/Fg527KEhTUS1A0MuetLz4g/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/b8f86b659450045c7884c84d6db552ebda42b9e77952f160554177e83d526724b7a40a67ab6c874577cf30f8b54c38f2a838ee6a0b06e82054b303fee56608dc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ff781cdf4ccbf05b682e7a84929288a835421501b376359aeb83c28bfa9bdab030094705d8d5df2711c26910a5520d9edb37c89c1b39da6285417572bcc6bf15", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c43c10399c2dde7a7a1105e9a5148ecf98cf78c0b7ef32cae0ac30116c824ee0da3c213de02a2510709b895332a3b302eaf463ec1be65f7e68f15df00c584783"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-12 22:17:35.393598) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-12 22:17:35.393976) ========= 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.tAESFzYuwF/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.W7BCjvV5ct/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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.004964 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-12 22:17:35.442538) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-12 22:17:35.445895) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-12 22:17:35.446268) ========= ========= Total master_lag: 0.26 =========