builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0114 starttime: 1480009101.08 results: success (0) buildid: 20161124073320 builduid: b0e3313adb3b4db383c0709379384882 revision: f37e99ebc6e0c682003b52573f415e5fd78d425a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-24 09:38:21.081281) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-24 09:38:21.081810) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-24 09:38:21.082149) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-24 09:38:21.108861) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 09:38:21.109274) ========= 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.PcMXCQDMuH/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.oNMDdPKran/Listeners TMPDIR=/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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-24 09:38:21-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 53.3M=0s 2016-11-24 09:38:21 (53.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.348250 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 09:38:21.482873) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 09:38:21.483198) ========= 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.PcMXCQDMuH/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.oNMDdPKran/Listeners TMPDIR=/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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.028325 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 09:38:21.533572) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-24 09:38:21.533917) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev f37e99ebc6e0c682003b52573f415e5fd78d425a --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-beta --rev f37e99ebc6e0c682003b52573f415e5fd78d425a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.PcMXCQDMuH/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.oNMDdPKran/Listeners TMPDIR=/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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-24 09:38:21,629 truncating revision to first 12 chars 2016-11-24 09:38:21,629 Setting DEBUG logging. 2016-11-24 09:38:21,629 attempt 1/10 2016-11-24 09:38:21,630 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/f37e99ebc6e0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-24 09:38:22,688 unpacking tar archive at: mozilla-beta-f37e99ebc6e0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.347030 ========= master_lag: 0.55 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-24 09:38:23.435066) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-24 09:38:23.435446) ========= script_repo_revision: f37e99ebc6e0c682003b52573f415e5fd78d425a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-24 09:38:23.435975) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-24 09:38:23.436246) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-24 09:38:23.579920) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-11-24 09:38:23.580277) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.PcMXCQDMuH/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.oNMDdPKran/Listeners TMPDIR=/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 09:38:23 INFO - MultiFileLogger online at 20161124 09:38:23 in /builds/slave/test 09:38:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 09:38:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:38:23 INFO - {'append_to_log': False, 09:38:23 INFO - 'base_work_dir': '/builds/slave/test', 09:38:23 INFO - 'blob_upload_branch': 'Mozilla-Beta', 09:38:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:38:23 INFO - 'branch': 'Mozilla-Beta', 09:38:23 INFO - 'buildbot_json_path': 'buildprops.json', 09:38:23 INFO - 'config_files': ('talos/mac_config.py',), 09:38:23 INFO - 'default_actions': ('clobber', 09:38:23 INFO - 'read-buildbot-config', 09:38:23 INFO - 'download-and-extract', 09:38:23 INFO - 'populate-webroot', 09:38:23 INFO - 'create-virtualenv', 09:38:23 INFO - 'install', 09:38:23 INFO - 'run-tests'), 09:38:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:38:23 INFO - 'download_minidump_stackwalk': True, 09:38:23 INFO - 'download_symbols': 'ondemand', 09:38:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:38:23 INFO - 'tooltool.py': '/tools/tooltool.py', 09:38:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:38:23 INFO - '/tools/misc-python/virtualenv.py')}, 09:38:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:38:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:38:23 INFO - 'installer_path': 'installer.exe', 09:38:23 INFO - 'log_level': 'info', 09:38:23 INFO - 'log_name': 'talos', 09:38:23 INFO - 'log_to_console': True, 09:38:23 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:38:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:38:23 INFO - 'opt_config_files': (), 09:38:23 INFO - 'pip_index': False, 09:38:23 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:38:23 INFO - 'cmd': ('bash', 09:38:23 INFO - '-c', 09:38:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:38:23 INFO - 'enabled': True, 09:38:23 INFO - 'halt_on_failure': False, 09:38:23 INFO - 'name': 'check_screen_resolution'},), 09:38:23 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:38:23 INFO - 'cmd': ('bash', 09:38:23 INFO - '-c', 09:38:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:38:23 INFO - 'enabled': True, 09:38:23 INFO - 'halt_on_failure': False, 09:38:23 INFO - 'name': 'check_screen_resolution'},), 09:38:23 INFO - 'run_cmd_checks_enabled': True, 09:38:23 INFO - 'sps_profile': False, 09:38:23 INFO - 'sps_profile_interval': 0, 09:38:23 INFO - 'suite': 'dromaeojs-e10s', 09:38:23 INFO - 'system_bits': '32', 09:38:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:38:23 INFO - 'title': 't-yosemite-r7-0114', 09:38:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:38:23 INFO - 'use_talos_json': True, 09:38:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:38:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:38:23 INFO - 'work_dir': 'build'} 09:38:23 INFO - [mozharness: 2016-11-24 17:38:23.781249Z] Running clobber step. 09:38:23 INFO - Running pre-action listener: _resource_record_pre_action 09:38:23 INFO - Running main action method: clobber 09:38:23 INFO - rmtree: /builds/slave/test/build 09:38:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:38:26 INFO - Running post-action listener: _resource_record_post_action 09:38:26 INFO - [mozharness: 2016-11-24 17:38:26.016306Z] Finished clobber step (success) 09:38:26 INFO - [mozharness: 2016-11-24 17:38:26.016464Z] Running read-buildbot-config step. 09:38:26 INFO - Running pre-action listener: _resource_record_pre_action 09:38:26 INFO - Running main action method: read_buildbot_config 09:38:26 INFO - Using buildbot properties: 09:38:26 INFO - { 09:38:26 INFO - "project": "", 09:38:26 INFO - "product": "firefox", 09:38:26 INFO - "script_repo_revision": "production", 09:38:26 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 09:38:26 INFO - "repository": "", 09:38:26 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 09:38:26 INFO - "buildid": "20161124073320", 09:38:26 INFO - "pgo_build": "False", 09:38:26 INFO - "basedir": "/builds/slave/test", 09:38:26 INFO - "buildnumber": 10, 09:38:26 INFO - "slavename": "t-yosemite-r7-0114", 09:38:26 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 09:38:26 INFO - "platform": "yosemite_r7", 09:38:26 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 09:38:26 INFO - "branch": "mozilla-beta", 09:38:26 INFO - "repo_path": "releases/mozilla-beta", 09:38:26 INFO - "revision": "f37e99ebc6e0c682003b52573f415e5fd78d425a", 09:38:26 INFO - "stage_platform": "macosx64", 09:38:26 INFO - "builduid": "b0e3313adb3b4db383c0709379384882", 09:38:26 INFO - "slavebuilddir": "test" 09:38:26 INFO - } 09:38:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/aezE_4YzTjqyouoa2mfF0g/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 09:38:26 INFO - Running post-action listener: _resource_record_post_action 09:38:26 INFO - [mozharness: 2016-11-24 17:38:26.021980Z] Finished read-buildbot-config step (success) 09:38:26 INFO - [mozharness: 2016-11-24 17:38:26.022197Z] Running download-and-extract step. 09:38:26 INFO - Running pre-action listener: _resource_record_pre_action 09:38:26 INFO - Running main action method: download_and_extract 09:38:26 INFO - mkdir: /builds/slave/test/build/tests 09:38:26 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')]} 09:38:26 INFO - trying https://queue.taskcluster.net/v1/task/aezE_4YzTjqyouoa2mfF0g/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 09:38:26 INFO - Downloading https://queue.taskcluster.net/v1/task/aezE_4YzTjqyouoa2mfF0g/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 09:38:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aezE_4YzTjqyouoa2mfF0g/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json'}, attempt #1 09:38:27 INFO - Downloaded 1165 bytes. 09:38:27 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 09:38:27 INFO - Using the following test package requirements: 09:38:27 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 09:38:27 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:38:27 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 09:38:27 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:38:27 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 09:38:27 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 09:38:27 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:38:27 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 09:38:27 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 09:38:27 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:38:27 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 09:38:27 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:38:27 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 09:38:27 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:38:27 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 09:38:27 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:38:27 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 09:38:27 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 09:38:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aezE_4YzTjqyouoa2mfF0g/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 09:38:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aezE_4YzTjqyouoa2mfF0g/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 09:38:27 INFO - Fetch https://queue.taskcluster.net/v1/task/aezE_4YzTjqyouoa2mfF0g/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 09:38:27 INFO - Expected file size: 16232523 09:38:34 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip', u'firefox-51.0.en-US.mac.talos.tests.zip'] for test suite category: talos 09:38:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aezE_4YzTjqyouoa2mfF0g/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 09:38:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aezE_4YzTjqyouoa2mfF0g/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 09:38:34 INFO - Fetch https://queue.taskcluster.net/v1/task/aezE_4YzTjqyouoa2mfF0g/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 09:38:35 INFO - Expected file size: 16232523 09:38:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aezE_4YzTjqyouoa2mfF0g/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 09:38:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aezE_4YzTjqyouoa2mfF0g/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 09:38:41 INFO - Fetch https://queue.taskcluster.net/v1/task/aezE_4YzTjqyouoa2mfF0g/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 09:38:42 INFO - Expected file size: 14414089 09:38:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:38:43 INFO - trying https://queue.taskcluster.net/v1/task/aezE_4YzTjqyouoa2mfF0g/artifacts/public/build/firefox-51.0.en-US.mac.dmg 09:38:43 INFO - Downloading https://queue.taskcluster.net/v1/task/aezE_4YzTjqyouoa2mfF0g/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 09:38:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aezE_4YzTjqyouoa2mfF0g/artifacts/public/build/firefox-51.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg'}, attempt #1 09:38:45 INFO - Downloaded 86049430 bytes. 09:38:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aezE_4YzTjqyouoa2mfF0g/artifacts/public/build/firefox-51.0.en-US.mac.dmg 09:38:45 INFO - mkdir: /builds/slave/test/properties 09:38:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:38:45 INFO - Writing to file /builds/slave/test/properties/build_url 09:38:45 INFO - Contents: 09:38:45 INFO - build_url:https://queue.taskcluster.net/v1/task/aezE_4YzTjqyouoa2mfF0g/artifacts/public/build/firefox-51.0.en-US.mac.dmg 09:38:47 INFO - Running post-action listener: _resource_record_post_action 09:38:47 INFO - Running post-action listener: set_extra_try_arguments 09:38:47 INFO - [mozharness: 2016-11-24 17:38:47.441851Z] Finished download-and-extract step (success) 09:38:47 INFO - [mozharness: 2016-11-24 17:38:47.441994Z] Running populate-webroot step. 09:38:47 INFO - Running pre-action listener: _resource_record_pre_action 09:38:47 INFO - Running main action method: populate_webroot 09:38:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:38:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:38:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:38:47 INFO - '--tppagecycles', 09:38:47 INFO - '7'], 09:38:47 INFO - 'tests': ['tsvgm']}}, 09:38:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:38:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:38:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:38:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:38:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:38:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:38:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:38:47 INFO - 'talos_options': ['--disable-e10s'], 09:38:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:38:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:38:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:38:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:38:47 INFO - 'talos_options': ['--disable-e10s'], 09:38:47 INFO - 'tests': ['damp', 'tps']}, 09:38:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:38:47 INFO - 'tests': ['damp', 'tps']}, 09:38:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:38:47 INFO - 'tests': ['dromaeo_dom']}, 09:38:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:38:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:38:47 INFO - 'tests': ['basic_compositor_video']}, 09:38:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:38:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:38:47 INFO - 'tests': ['a11yr', 09:38:47 INFO - 'ts_paint', 09:38:47 INFO - 'tpaint', 09:38:47 INFO - 'sessionrestore', 09:38:47 INFO - 'sessionrestore_no_auto_restore', 09:38:47 INFO - 'tabpaint']}, 09:38:47 INFO - 'other-e10s': {'tests': ['a11yr', 09:38:47 INFO - 'ts_paint', 09:38:47 INFO - 'tpaint', 09:38:47 INFO - 'sessionrestore', 09:38:47 INFO - 'sessionrestore_no_auto_restore', 09:38:47 INFO - 'tabpaint']}, 09:38:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:38:47 INFO - 'ts_paint', 09:38:47 INFO - 'tpaint', 09:38:47 INFO - 'sessionrestore', 09:38:47 INFO - 'sessionrestore_no_auto_restore', 09:38:47 INFO - 'tabpaint']}, 09:38:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:38:47 INFO - 'ts_paint', 09:38:47 INFO - 'tpaint', 09:38:47 INFO - 'sessionrestore', 09:38:47 INFO - 'sessionrestore_no_auto_restore', 09:38:47 INFO - 'tabpaint']}, 09:38:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:38:47 INFO - 'tests': ['a11yr', 09:38:47 INFO - 'ts_paint', 09:38:47 INFO - 'tpaint', 09:38:47 INFO - 'sessionrestore', 09:38:47 INFO - 'sessionrestore_no_auto_restore', 09:38:47 INFO - 'tabpaint']}, 09:38:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:38:47 INFO - 'tests': ['a11yr', 09:38:47 INFO - 'ts_paint', 09:38:47 INFO - 'tpaint', 09:38:47 INFO - 'sessionrestore', 09:38:47 INFO - 'sessionrestore_no_auto_restore', 09:38:47 INFO - 'tabpaint']}, 09:38:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:38:47 INFO - 'tests': ['tsvgx', 09:38:47 INFO - 'tsvgr_opacity', 09:38:47 INFO - 'tart', 09:38:47 INFO - 'tscrollx', 09:38:47 INFO - 'cart']}, 09:38:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:38:47 INFO - 'tsvgr_opacity', 09:38:47 INFO - 'tart', 09:38:47 INFO - 'tscrollx', 09:38:47 INFO - 'cart']}, 09:38:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:38:47 INFO - 'talos_options': ['--disable-e10s'], 09:38:47 INFO - 'tests': ['tp5o']}, 09:38:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:38:47 INFO - 'tests': ['tp5o']}, 09:38:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:38:47 INFO - 'talos_options': ['--disable-e10s', 09:38:47 INFO - '--xperf_path', 09:38:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:38:47 INFO - 'tests': ['tp5n']}, 09:38:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:38:47 INFO - 'talos_options': ['--xperf_path', 09:38:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:38:47 INFO - 'tests': ['tp5n']}}, 09:38:47 INFO - 'talos.zip': {'path': '', 09:38:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:38:47 INFO - Running post-action listener: _resource_record_post_action 09:38:47 INFO - [mozharness: 2016-11-24 17:38:47.460372Z] Finished populate-webroot step (success) 09:38:47 INFO - [mozharness: 2016-11-24 17:38:47.460506Z] Running create-virtualenv step. 09:38:47 INFO - Running pre-action listener: _resource_record_pre_action 09:38:47 INFO - Running main action method: create_virtualenv 09:38:47 INFO - Creating virtualenv /builds/slave/test/build/venv 09:38:47 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 09:38:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:38:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:38:47 INFO - Using real prefix '/tools/python27' 09:38:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:38:48 INFO - Installing distribute.............................................................................................................................................................................................done. 09:38:51 INFO - Installing pip.................done. 09:38:51 INFO - Return code: 0 09:38:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:38:51 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')]} 09:38:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:38:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:51 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')]} 09:38:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:38:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:51 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 0x10694e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068c4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1d0c9af60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106762d30>, '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 0x1065c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10675ab20>, '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.PcMXCQDMuH/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.oNMDdPKran/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 09:38:51 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 09:38:51 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 09:38:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PcMXCQDMuH/Render', 09:38:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:38:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:38:51 INFO - 'HOME': '/Users/cltbld', 09:38:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:38:51 INFO - 'LOGNAME': 'cltbld', 09:38:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:38:51 INFO - 'MOZ_NO_REMOTE': '1', 09:38:51 INFO - 'NO_EM_RESTART': '1', 09:38:51 INFO - 'PAGER': '/bin/cat', 09:38:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:38:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:38:51 INFO - 'PWD': '/builds/slave/test', 09:38:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:38:51 INFO - 'SHELL': '/bin/bash', 09:38:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oNMDdPKran/Listeners', 09:38:51 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 09:38:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:38:51 INFO - 'USER': 'cltbld', 09:38:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:38:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:38:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:38:51 INFO - 'XPC_FLAGS': '0x0', 09:38:51 INFO - 'XPC_SERVICE_NAME': '0', 09:38:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:38:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:38:51 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 09:38:51 INFO - Cleaning up... 09:38:51 INFO - Return code: 0 09:38:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:38:51 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')]} 09:38:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:38:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:51 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')]} 09:38:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:38:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:51 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 0x10694e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068c4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1d0c9af60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106762d30>, '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 0x1065c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10675ab20>, '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.PcMXCQDMuH/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.oNMDdPKran/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 09:38:51 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 09:38:51 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 09:38:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PcMXCQDMuH/Render', 09:38:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:38:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:38:51 INFO - 'HOME': '/Users/cltbld', 09:38:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:38:51 INFO - 'LOGNAME': 'cltbld', 09:38:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:38:51 INFO - 'MOZ_NO_REMOTE': '1', 09:38:51 INFO - 'NO_EM_RESTART': '1', 09:38:51 INFO - 'PAGER': '/bin/cat', 09:38:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:38:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:38:51 INFO - 'PWD': '/builds/slave/test', 09:38:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:38:51 INFO - 'SHELL': '/bin/bash', 09:38:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oNMDdPKran/Listeners', 09:38:51 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 09:38:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:38:51 INFO - 'USER': 'cltbld', 09:38:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:38:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:38:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:38:51 INFO - 'XPC_FLAGS': '0x0', 09:38:51 INFO - 'XPC_SERVICE_NAME': '0', 09:38:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:38:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:38:51 INFO - Downloading/unpacking psutil>=3.1.1 09:38:51 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 09:38:51 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 09:38:51 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 09:38:51 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 09:38:51 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 09:38:51 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 09:38:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:38:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:38:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:38:55 INFO - Installing collected packages: psutil 09:38:55 INFO - Running setup.py install for psutil 09:38:55 INFO - building 'psutil._psutil_osx' extension 09:38:55 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 09:38:55 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 09:38:55 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 09:38:55 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 09:38:55 INFO - building 'psutil._psutil_posix' extension 09:38:55 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 09:38:56 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:38:56 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:38:56 INFO - ^ 09:38:56 INFO - 1 warning generated. 09:38:56 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 09:38:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:38:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:38:56 INFO - Successfully installed psutil 09:38:56 INFO - Cleaning up... 09:38:56 INFO - Return code: 0 09:38:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:38:56 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')]} 09:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:38:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:56 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')]} 09:38:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:38:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:56 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 0x10694e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068c4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1d0c9af60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106762d30>, '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 0x1065c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10675ab20>, '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.PcMXCQDMuH/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.oNMDdPKran/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 09:38:56 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 09:38:56 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 09:38:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PcMXCQDMuH/Render', 09:38:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:38:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:38:56 INFO - 'HOME': '/Users/cltbld', 09:38:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:38:56 INFO - 'LOGNAME': 'cltbld', 09:38:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:38:56 INFO - 'MOZ_NO_REMOTE': '1', 09:38:56 INFO - 'NO_EM_RESTART': '1', 09:38:56 INFO - 'PAGER': '/bin/cat', 09:38:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:38:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:38:56 INFO - 'PWD': '/builds/slave/test', 09:38:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:38:56 INFO - 'SHELL': '/bin/bash', 09:38:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oNMDdPKran/Listeners', 09:38:56 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 09:38:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:38:56 INFO - 'USER': 'cltbld', 09:38:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:38:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:38:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:38:56 INFO - 'XPC_FLAGS': '0x0', 09:38:56 INFO - 'XPC_SERVICE_NAME': '0', 09:38:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:38:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:38:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:38:56 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 09:38:56 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 09:38:56 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 09:38:56 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 09:38:56 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 09:38:56 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 09:38:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:38:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:38:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:38:59 INFO - Installing collected packages: mozsystemmonitor 09:38:59 INFO - Running setup.py install for mozsystemmonitor 09:38:59 INFO - Successfully installed mozsystemmonitor 09:38:59 INFO - Cleaning up... 09:38:59 INFO - Return code: 0 09:38:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:38: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')]} 09:38:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:38:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38: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')]} 09:38:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:38:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38: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', '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 0x10694e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068c4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1d0c9af60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106762d30>, '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 0x1065c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10675ab20>, '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.PcMXCQDMuH/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.oNMDdPKran/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 09:38: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:38: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 jsonschema==2.5.1 09:38:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PcMXCQDMuH/Render', 09:38:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:38:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:38:59 INFO - 'HOME': '/Users/cltbld', 09:38:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:38:59 INFO - 'LOGNAME': 'cltbld', 09:38:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:38:59 INFO - 'MOZ_NO_REMOTE': '1', 09:38:59 INFO - 'NO_EM_RESTART': '1', 09:38:59 INFO - 'PAGER': '/bin/cat', 09:38:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:38:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:38:59 INFO - 'PWD': '/builds/slave/test', 09:38:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:38:59 INFO - 'SHELL': '/bin/bash', 09:38:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oNMDdPKran/Listeners', 09:38:59 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 09:38:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:38:59 INFO - 'USER': 'cltbld', 09:38:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:38:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:38:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:38:59 INFO - 'XPC_FLAGS': '0x0', 09:38:59 INFO - 'XPC_SERVICE_NAME': '0', 09:38:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:38:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:38:59 INFO - Downloading/unpacking jsonschema==2.5.1 09:38: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 09:38: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 09:38: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 09:38: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 09:38: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 09:38: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 09:39:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:39:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:39: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 09:39: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 09:39: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 09:39: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 09:39: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 09:39: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 09:39:02 INFO - Downloading functools32-3.2.3-2.tar.gz 09:39:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:39:02 INFO - warning: no files found matching '*.txt' 09:39:02 INFO - no previously-included directories found matching 'build' 09:39:02 INFO - no previously-included directories found matching 'dist' 09:39:02 INFO - no previously-included directories found matching '.git*' 09:39:02 INFO - Installing collected packages: jsonschema, functools32 09:39:02 INFO - Running setup.py install for functools32 09:39:02 INFO - warning: no files found matching '*.txt' 09:39:02 INFO - no previously-included directories found matching 'build' 09:39:02 INFO - no previously-included directories found matching 'dist' 09:39:02 INFO - no previously-included directories found matching '.git*' 09:39:02 INFO - Successfully installed jsonschema functools32 09:39:02 INFO - Cleaning up... 09:39:02 INFO - Return code: 0 09:39:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:39: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')]} 09:39:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39: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')]} 09:39:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39: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', '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 0x10694e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068c4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1d0c9af60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106762d30>, '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 0x1065c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10675ab20>, '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.PcMXCQDMuH/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.oNMDdPKran/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 09:39: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:39: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 functools32==3.2.3-2 09:39:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PcMXCQDMuH/Render', 09:39:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:39:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:39:02 INFO - 'HOME': '/Users/cltbld', 09:39:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:39:02 INFO - 'LOGNAME': 'cltbld', 09:39:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:02 INFO - 'MOZ_NO_REMOTE': '1', 09:39:02 INFO - 'NO_EM_RESTART': '1', 09:39:02 INFO - 'PAGER': '/bin/cat', 09:39:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:39:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:02 INFO - 'PWD': '/builds/slave/test', 09:39:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:39:02 INFO - 'SHELL': '/bin/bash', 09:39:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oNMDdPKran/Listeners', 09:39:02 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 09:39:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:39:02 INFO - 'USER': 'cltbld', 09:39:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:39:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:39:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:02 INFO - 'XPC_FLAGS': '0x0', 09:39:02 INFO - 'XPC_SERVICE_NAME': '0', 09:39:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:39:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:39:03 INFO - Cleaning up... 09:39:03 INFO - Return code: 0 09:39:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:39:03 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')]} 09:39:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:03 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')]} 09:39:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:03 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 0x10694e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068c4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1d0c9af60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106762d30>, '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 0x1065c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10675ab20>, '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.PcMXCQDMuH/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.oNMDdPKran/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 09:39:03 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 09:39:03 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 09:39:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PcMXCQDMuH/Render', 09:39:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:39:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:39:03 INFO - 'HOME': '/Users/cltbld', 09:39:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:39:03 INFO - 'LOGNAME': 'cltbld', 09:39:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:03 INFO - 'MOZ_NO_REMOTE': '1', 09:39:03 INFO - 'NO_EM_RESTART': '1', 09:39:03 INFO - 'PAGER': '/bin/cat', 09:39:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:39:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:03 INFO - 'PWD': '/builds/slave/test', 09:39:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:39:03 INFO - 'SHELL': '/bin/bash', 09:39:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oNMDdPKran/Listeners', 09:39:03 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 09:39:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:39:03 INFO - 'USER': 'cltbld', 09:39:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:39:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:39:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:03 INFO - 'XPC_FLAGS': '0x0', 09:39:03 INFO - 'XPC_SERVICE_NAME': '0', 09:39:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:39:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:03 INFO - Downloading/unpacking blobuploader==1.2.4 09:39:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:39:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:39:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:05 INFO - Downloading blobuploader-1.2.4.tar.gz 09:39:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:39:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:39:05 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 09:39:05 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 09:39:05 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 09:39:05 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 09:39:05 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 09:39:05 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 09:39:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:39:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:39: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 09:39: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 09:39: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 09:39: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 09:39: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 09:39: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 09:39:07 INFO - Downloading docopt-0.6.1.tar.gz 09:39:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:39:07 INFO - Installing collected packages: blobuploader, requests, docopt 09:39:07 INFO - Running setup.py install for blobuploader 09:39:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:39:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:39:07 INFO - Running setup.py install for requests 09:39:07 INFO - Running setup.py install for docopt 09:39:08 INFO - Successfully installed blobuploader requests docopt 09:39:08 INFO - Cleaning up... 09:39:08 INFO - Return code: 0 09:39:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:39:08 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')]} 09:39:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:08 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')]} 09:39:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:08 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 0x10694e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068c4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1d0c9af60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106762d30>, '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 0x1065c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10675ab20>, '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.PcMXCQDMuH/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.oNMDdPKran/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 09:39:08 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 09:39:08 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 09:39:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PcMXCQDMuH/Render', 09:39:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:39:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:39:08 INFO - 'HOME': '/Users/cltbld', 09:39:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:39:08 INFO - 'LOGNAME': 'cltbld', 09:39:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:08 INFO - 'MOZ_NO_REMOTE': '1', 09:39:08 INFO - 'NO_EM_RESTART': '1', 09:39:08 INFO - 'PAGER': '/bin/cat', 09:39:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:39:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:08 INFO - 'PWD': '/builds/slave/test', 09:39:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:39:08 INFO - 'SHELL': '/bin/bash', 09:39:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oNMDdPKran/Listeners', 09:39:08 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 09:39:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:39:08 INFO - 'USER': 'cltbld', 09:39:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:39:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:39:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:08 INFO - 'XPC_FLAGS': '0x0', 09:39:08 INFO - 'XPC_SERVICE_NAME': '0', 09:39:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:39:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:39:08 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-GW3zbv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:39:08 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-9PvrNH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:39:08 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-eh3u7T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:39:08 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-NA0K3n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:39:08 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-eUUnQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:39:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:39:08 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-6ZUN_P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:39:09 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-grU5PS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:39:09 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-5PsPvD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:39:09 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-LPHjH2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:39:09 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-A1G2l3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:39:09 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-hu1B4p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:39:09 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-JCw6Rd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:39:09 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-IT3hjU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:39:09 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-t39zCH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:39:09 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-KnIcUm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:39:09 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-OnHR5F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:39:10 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-nqsJa5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:39:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:39:10 INFO - Running setup.py install for manifestparser 09:39:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:39:10 INFO - Running setup.py install for mozcrash 09:39:10 INFO - Running setup.py install for mozdebug 09:39:10 INFO - Running setup.py install for mozdevice 09:39:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:39:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:39:10 INFO - Running setup.py install for mozfile 09:39:10 INFO - Running setup.py install for mozhttpd 09:39:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:39:11 INFO - Running setup.py install for mozinfo 09:39:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:39:11 INFO - Running setup.py install for mozInstall 09:39:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:39:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:39:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:39:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:39:11 INFO - Running setup.py install for mozleak 09:39:11 INFO - Running setup.py install for mozlog 09:39:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:39:11 INFO - Running setup.py install for moznetwork 09:39:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:39:11 INFO - Running setup.py install for mozprocess 09:39:11 INFO - Running setup.py install for mozprofile 09:39:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:39:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:39:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:39:12 INFO - Running setup.py install for mozrunner 09:39:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:39:12 INFO - Running setup.py install for mozscreenshot 09:39:12 INFO - Running setup.py install for moztest 09:39:12 INFO - Running setup.py install for mozversion 09:39:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:39:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:39:12 INFO - Cleaning up... 09:39:12 INFO - Return code: 0 09:39:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:39:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:39:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:39:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:12 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 0x10694e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068c4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1d0c9af60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106762d30>, '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 0x1065c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10675ab20>, '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.PcMXCQDMuH/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.oNMDdPKran/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 09:39:12 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 09:39:12 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 09:39:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PcMXCQDMuH/Render', 09:39:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:39:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:39:12 INFO - 'HOME': '/Users/cltbld', 09:39:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:39:12 INFO - 'LOGNAME': 'cltbld', 09:39:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:12 INFO - 'MOZ_NO_REMOTE': '1', 09:39:12 INFO - 'NO_EM_RESTART': '1', 09:39:12 INFO - 'PAGER': '/bin/cat', 09:39:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:39:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:12 INFO - 'PWD': '/builds/slave/test', 09:39:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:39:12 INFO - 'SHELL': '/bin/bash', 09:39:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oNMDdPKran/Listeners', 09:39:12 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 09:39:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:39:12 INFO - 'USER': 'cltbld', 09:39:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:39:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:39:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:12 INFO - 'XPC_FLAGS': '0x0', 09:39:12 INFO - 'XPC_SERVICE_NAME': '0', 09:39:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:39:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:39:13 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-sPpE_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:39:13 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)) 09:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:39:13 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-NYdmQl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:39:13 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)) 09:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:39:13 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-XOLHO6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:39:13 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)) 09:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:39:13 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-OEDmZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:39:13 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)) 09:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:39:13 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-ldMrxV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:39:13 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)) 09:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:39:13 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-PXuIyr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:39:13 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)) 09:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:39:13 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-wD9qet-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:39:13 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)) 09:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:39:13 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-dmRo8Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:39:13 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)) 09:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:39:13 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-kxlYqU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:39:13 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)) 09:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:39:13 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-m4cFW8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:39:14 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)) 09:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:39:14 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-BMbhAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:39:14 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)) 09:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:39:14 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-9ocuNC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:39:14 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)) 09:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:39:14 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-a2oavc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:39:14 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)) 09:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:39:14 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-5yaoZ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:39:14 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)) 09:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:39:14 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-WwBK9D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:39:14 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)) 09:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:39:14 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-KMRwFA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:39:14 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)) 09:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:39:14 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-qSyvyS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:39:14 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)) 09:39:14 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)) 09:39:14 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)) 09:39:14 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)) 09:39:14 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)) 09:39:14 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)) 09:39:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:39:14 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 09:39:14 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 09:39:14 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 09:39:14 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 09:39:14 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 09:39:14 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 09:39:17 INFO - Downloading blessings-1.6.tar.gz 09:39:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:39:17 INFO - Installing collected packages: blessings 09:39:17 INFO - Running setup.py install for blessings 09:39:17 INFO - Successfully installed blessings 09:39:17 INFO - Cleaning up... 09:39:17 INFO - Return code: 0 09:39:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:39:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:39:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:39:17 INFO - Reading from file tmpfile_stdout 09:39:17 INFO - Current package versions: 09:39:17 INFO - blessings == 1.6 09:39:17 INFO - blobuploader == 1.2.4 09:39:17 INFO - docopt == 0.6.1 09:39:17 INFO - functools32 == 3.2.3-2 09:39:17 INFO - jsonschema == 2.5.1 09:39:17 INFO - manifestparser == 1.1 09:39:17 INFO - mozInstall == 1.12 09:39:17 INFO - mozcrash == 0.17 09:39:17 INFO - mozdebug == 0.1 09:39:17 INFO - mozdevice == 0.48 09:39:17 INFO - mozfile == 1.2 09:39:17 INFO - mozhttpd == 0.7 09:39:17 INFO - mozinfo == 0.9 09:39:17 INFO - mozleak == 0.1 09:39:17 INFO - mozlog == 3.4 09:39:17 INFO - moznetwork == 0.27 09:39:17 INFO - mozprocess == 0.23 09:39:17 INFO - mozprofile == 0.28 09:39:17 INFO - mozrunner == 6.12 09:39:17 INFO - mozscreenshot == 0.1 09:39:17 INFO - mozsystemmonitor == 0.3 09:39:17 INFO - moztest == 0.7 09:39:17 INFO - mozversion == 1.4 09:39:17 INFO - psutil == 3.1.1 09:39:17 INFO - requests == 1.2.3 09:39:17 INFO - wsgiref == 0.1.2 09:39:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:39:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:39:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:18 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')]} 09:39:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:18 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 0x10694e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068c4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1d0c9af60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106762d30>, '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 0x1065c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10675ab20>, '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.PcMXCQDMuH/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.oNMDdPKran/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 09:39:18 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 09:39:18 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 09:39:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PcMXCQDMuH/Render', 09:39:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:39:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:39:18 INFO - 'HOME': '/Users/cltbld', 09:39:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:39:18 INFO - 'LOGNAME': 'cltbld', 09:39:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:18 INFO - 'MOZ_NO_REMOTE': '1', 09:39:18 INFO - 'NO_EM_RESTART': '1', 09:39:18 INFO - 'PAGER': '/bin/cat', 09:39:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:39:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:18 INFO - 'PWD': '/builds/slave/test', 09:39:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:39:18 INFO - 'SHELL': '/bin/bash', 09:39:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oNMDdPKran/Listeners', 09:39:18 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 09:39:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:39:18 INFO - 'USER': 'cltbld', 09:39:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:39:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:39:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:18 INFO - 'XPC_FLAGS': '0x0', 09:39:18 INFO - 'XPC_SERVICE_NAME': '0', 09:39:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:39:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:18 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)) 09:39:18 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)) 09:39:18 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)) 09:39:18 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)) 09:39:18 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)) 09:39:18 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)) 09:39:18 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)) 09:39:18 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)) 09:39:18 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)) 09:39:18 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)) 09:39:18 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)) 09:39:18 INFO - Cleaning up... 09:39:18 INFO - Return code: 0 09:39:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:39:18 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')]} 09:39:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:18 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')]} 09:39:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:18 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 0x10694e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1068c4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1d0c9af60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106762d30>, '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 0x1065c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10675ab20>, '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.PcMXCQDMuH/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.oNMDdPKran/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 09:39:18 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 09:39:18 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 09:39:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PcMXCQDMuH/Render', 09:39:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:39:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:39:18 INFO - 'HOME': '/Users/cltbld', 09:39:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:39:18 INFO - 'LOGNAME': 'cltbld', 09:39:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:18 INFO - 'MOZ_NO_REMOTE': '1', 09:39:18 INFO - 'NO_EM_RESTART': '1', 09:39:18 INFO - 'PAGER': '/bin/cat', 09:39:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:39:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:18 INFO - 'PWD': '/builds/slave/test', 09:39:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:39:18 INFO - 'SHELL': '/bin/bash', 09:39:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oNMDdPKran/Listeners', 09:39:18 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 09:39:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:39:18 INFO - 'USER': 'cltbld', 09:39:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:39:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:39:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:18 INFO - 'XPC_FLAGS': '0x0', 09:39:18 INFO - 'XPC_SERVICE_NAME': '0', 09:39:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:39:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:39:18 INFO - Cleaning up... 09:39:18 INFO - Return code: 0 09:39:18 INFO - Running post-action listener: _resource_record_post_action 09:39:18 INFO - Running post-action listener: _start_resource_monitoring 09:39:18 INFO - Starting resource monitoring. 09:39:18 INFO - [mozharness: 2016-11-24 17:39:18.927879Z] Finished create-virtualenv step (success) 09:39:18 INFO - [mozharness: 2016-11-24 17:39:18.928838Z] Running install step. 09:39:18 INFO - Running pre-action listener: _resource_record_pre_action 09:39:18 INFO - Running main action method: install 09:39:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:39:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:39:19 INFO - Reading from file tmpfile_stdout 09:39:19 INFO - Detecting whether we're running mozinstall >=1.0... 09:39:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:39:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:39:19 INFO - Reading from file tmpfile_stdout 09:39:19 INFO - Output received: 09:39:19 INFO - Usage: mozinstall [options] installer 09:39:19 INFO - Options: 09:39:19 INFO - -h, --help show this help message and exit 09:39:19 INFO - -d DEST, --destination=DEST 09:39:19 INFO - Directory to install application into. [default: 09:39:19 INFO - "/builds/slave/test"] 09:39:19 INFO - --app=APP Application being installed. [default: firefox] 09:39:19 INFO - mkdir: /builds/slave/test/build/application 09:39:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:39:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0.en-US.mac.dmg --destination /builds/slave/test/build/application 09:39:41 INFO - Reading from file tmpfile_stdout 09:39:41 INFO - Output received: 09:39:41 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 09:39:41 INFO - Running post-action listener: _resource_record_post_action 09:39:41 INFO - [mozharness: 2016-11-24 17:39:41.028996Z] Finished install step (success) 09:39:41 INFO - [mozharness: 2016-11-24 17:39:41.029156Z] Running run-tests step. 09:39:41 INFO - Running pre-action listener: _resource_record_pre_action 09:39:41 INFO - Running main action method: run_tests 09:39:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:39:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:39:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:39:41 INFO - 2016-11-24 09:39:41.043 screenresolution[1621:7284] starting screenresolution argv=screenresolution get 09:39:41 INFO - 2016-11-24 09:39:41.046 screenresolution[1621:7284] Display 0: 1600x1200x32@60 09:39:41 INFO - 2016-11-24 09:39:41.052 screenresolution[1622:7287] starting screenresolution argv=screenresolution list 09:39:41 INFO - Available Modes on Display 0 09:39:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:39:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:39:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:39:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:39:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:39:41 INFO - Intel Iris: 09:39:41 INFO - Chipset Model: Intel Iris 09:39:41 INFO - Type: GPU 09:39:41 INFO - Bus: Built-In 09:39:41 INFO - VRAM (Dynamic, Max): 1536 MB 09:39:41 INFO - Vendor: Intel (0x8086) 09:39:41 INFO - Device ID: 0x0a2e 09:39:41 INFO - Revision ID: 0x0009 09:39:41 INFO - Displays: 09:39:41 INFO - Display: 09:39:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:39:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:39:41 INFO - Display Serial Number: 1600x1200 60 09:39:41 INFO - Main Display: Yes 09:39:41 INFO - Mirror: Off 09:39:41 INFO - Online: Yes 09:39:41 INFO - Rotation: Supported 09:39:41 INFO - Return code: 0 09:39:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:39:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:39:41 INFO - Python 2.7.3 09:39:41 INFO - Return code: 0 09:39:41 INFO - grabbing minidump binary from tooltool 09:39:41 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')]} 09:39:41 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 0x106762d30>, '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 0x1065c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10675ab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:39:41 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 09:39:41 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 09:39:41 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 09:39:41 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:39:41 INFO - Return code: 0 09:39:41 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:39:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:39:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:39:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:39:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:39:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aezE_4YzTjqyouoa2mfF0g/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0114', '--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 09:39:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aezE_4YzTjqyouoa2mfF0g/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0114 --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 09:39:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PcMXCQDMuH/Render', 09:39:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:39:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:39:41 INFO - 'HOME': '/Users/cltbld', 09:39:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:39:41 INFO - 'LOGNAME': 'cltbld', 09:39:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:39:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:39:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:41 INFO - 'MOZ_NO_REMOTE': '1', 09:39:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:39:41 INFO - 'NO_EM_RESTART': '1', 09:39:41 INFO - 'PAGER': '/bin/cat', 09:39:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:39:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:41 INFO - 'PWD': '/builds/slave/test', 09:39:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:39:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:39:41 INFO - 'SHELL': '/bin/bash', 09:39:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oNMDdPKran/Listeners', 09:39:41 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 09:39:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:39:41 INFO - 'USER': 'cltbld', 09:39:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:39:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:39:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:41 INFO - 'XPC_FLAGS': '0x0', 09:39:41 INFO - 'XPC_SERVICE_NAME': '0', 09:39:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:39:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aezE_4YzTjqyouoa2mfF0g/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0114', '--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 09:39:41 INFO - mozversion application_buildid: 20161124073320 09:39:41 INFO - mozversion application_changeset: f37e99ebc6e0c682003b52573f415e5fd78d425a 09:39:41 INFO - mozversion application_display_name: Firefox 09:39:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:39:41 INFO - mozversion application_name: Firefox 09:39:41 INFO - mozversion application_remotingname: firefox 09:39:41 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:39:41 INFO - mozversion application_vendor: Mozilla 09:39:41 INFO - mozversion application_version: 51.0 09:39:41 INFO - mozversion platform_buildid: 20161124073320 09:39:41 INFO - mozversion platform_changeset: f37e99ebc6e0c682003b52573f415e5fd78d425a 09:39:41 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:39:41 INFO - mozversion platform_version: 51.0 09:39:41 INFO - using testdate: 1480009181 09:39:41 INFO - actual date: 1480009181 09:39:41 INFO - starting webserver on 'localhost:49236' 09:39:41 INFO - SUITE-START | Running 2 tests 09:39:41 INFO - TEST-START | dromaeo_css 09:39:41 INFO - operating with platform_type : mac_ 09:39:41 INFO - Initialising browser for dromaeo_css test... 09:39:41 INFO - TEST-INFO | started process 1632 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/tmpYPDhdy/profile http://localhost:49236/getInfo.html) 09:39:44 INFO - PROCESS | 1632 | __metrics Screen width/height:1600/1200 09:39:44 INFO - PROCESS | 1632 | colorDepth:24 09:39:44 INFO - PROCESS | 1632 | Browser inner width/height: 1024/689 09:39:44 INFO - PROCESS | 1632 | __metrics 09:39:44 ERROR - PROCESS | 1632 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3015: TypeError: this.tabs is undefined 09:39:44 INFO - TEST-INFO | 1632: exit 0 09:39:44 INFO - Browser initialized. 09:39:44 INFO - Running cycle 1/1 for dromaeo_css test... 09:39:44 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/tmpYPDhdy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:39:56 INFO - PROCESS | 1636 | RSS: Main: 174526464 09:39:56 INFO - PROCESS | 1636 | 09:40:46 INFO - PROCESS | 1636 | 1480009246557 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] 09:42:58 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49236/tests/dromaeo/cssquery-ext.html) 09:42:59 INFO - PROCESS | 1636 | RSS: Main: 185430016 09:42:59 INFO - PROCESS | 1636 | 09:46:01 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-ext.html (next: http://localhost:49236/tests/dromaeo/cssquery-jquery.html) 09:46:02 INFO - PROCESS | 1636 | RSS: Main: 198119424 09:46:02 INFO - PROCESS | 1636 | 09:49:04 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49236/tests/dromaeo/cssquery-mootools.html) 09:49:04 INFO - PROCESS | 1636 | RSS: Main: 199450624 09:49:04 INFO - PROCESS | 1636 | 09:52:06 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49236/tests/dromaeo/cssquery-prototype.html) 09:52:07 INFO - PROCESS | 1636 | RSS: Main: 204521472 09:52:07 INFO - PROCESS | 1636 | 09:55:10 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49236/tests/dromaeo/cssquery-yui.html) 09:55:10 INFO - PROCESS | 1636 | RSS: Main: 206860288 09:55:10 INFO - PROCESS | 1636 | 09:58:13 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-yui.html (next: http://localhost:49236/tests/dromaeo/cssquery-dojo.html) 09:58:13 INFO - PROCESS | 1636 | RSS: Main: 207507456 09:58:13 INFO - PROCESS | 1636 | 09:58:13 INFO - PROCESS | 1636 | __start_tp_report 09:58:13 INFO - PROCESS | 1636 | _x_x_mozilla_page_load 09:58:13 INFO - PROCESS | 1636 | _x_x_mozilla_page_load_details 09:58:13 INFO - PROCESS | 1636 | |i|pagename|runs| 09:58:13 INFO - PROCESS | 1636 | |0;dojo.html;3558.626344233857;3608.4046132388157;3630.546181727285;3633.3459977204093;3636.599974002859;5914.585978981473;5931.614445061074;5939.07944268639;6075.027995520718;6092.147099406086;4350.934735978963;6040.244969378828;6046.153538504613;6084.969575152118;6089.29973053099;5144.717040562768;5371.4897084776985;5503.422140675211;5507.421720719327;5510.559155267589;5467.316585426822;5477.178423236506;5490.6431081979745;5500.312460942382;5518.889622207554;5340.465953404668;5373.785048598052;5515.007298686235;5519.475649813261;5551.3893471718075;5410.48600382963;5414.593905457087;5484;5500.889982200333;5566.749496272637;4653.7905794239;4718.457377401608;4853.39332583427;5436.537894278991;5489.615726899118;5837.09525023622;6026.156338112668;6032.517398608101;6074.9392506075255;6140.662263575501;5171.896562068775;6237.750489980395;6272.905906411407;6315.905261421037;6409.519286053518;6152.046432802923;6191.845203869894;6385.138006369174;6512.9579267317;6542.967285163591;6196.659183744938;6225.346338634424;6230.190075290274;6232.0963460298;6251.249850018027;6373.840653983595;6386.616802991835;6478.514111441661;6515;6522.510811689142;6266.185395898595;6346.143270658495;6365.013422919455;6368.458681012074;6369.840753981095;6462.48300135988;6487.513436492188;6490.675466226669;6505.316941721146;6519.8044058678315;6194.690265486708;6277.96861015692;6296.087067375205;6316.178896743394;6378.011408231731;6370.968145159244;6401.103845461639;6413.4869210463985;6415.26224484181;6418.101465794793;5153.7165455900285;5164.509371609691;5172.086328058643;5178.482151784791;5192.558632516203;4527.59251667345;4566.995261042632;4599.862004139881;4668.393108895822;4698.060387922429;6057.3639767824625;6116.831988692009;6127.479164271087;6147;6149.2620885494025;6470.4823614110755;6472.352764723584;6492.642904640195;6508.153939987771;6526.869462610816;5926.7925622603;6059.091136329585;6062.242219722535;6105.778844231171;6171.59884607499;5690.118031705092;5690.487856092972;5703.17303990919;5722.62802917809;5760.53915686744;6562.868742625216;6655.500837437212;6663.26704062543;6671.099401580822;6686.297938716365;6236.6258024518675;6283.560150789401;6289.119523266655;6398.072279519351;6450.967745161244;6515.28331883502;6669.599824010575;6678.599284042973;6680.933190668031;6685.598864068172;6349.555531112777;6372.299047104908;6377.93622063792;6382.840428989312;6394.0408938659575;6219.284782250099;6269.40440658155;6418.19772528434;6469.320721324193;6503.707333170113;6094;6190.164327815687;6259.186305780219;6289.685515724287;6316.589421687576;6293.653849038347;6297.748090076529;6308.179936608211;6309.242890853127;6321.715522801393;4961.70229786214;6141.416565426277;6212.9068063979985;6246.531510136667;6303.873922521616;6187.597806142587;6188.44304012641;6217.844553886189;6259.12372267892;6260;6248.625082495065;6263.530235232284;6268.749250029948;6282.057691346335;6291.842703932255 09:58:13 INFO - PROCESS | 1636 | |1;ext.html;463.9953600463994;495.74469148388584;534.5803544217789;546.1534621336926;561.8791959728659;32070.198245043855;37629.62370376302;41247;43453.78273108638;45804.083918321616;43917.560824391745;44815.77592112035;45132.77433612827;45298;45465.7726711366;10025.248106392031;10170.64402745904;10214.28500005;10215.744606384826;10232.74418139545;9937.453440060794;10034.84947725781;10060.69817905464;10073;10105;8742.344324175712;9972.700818975407;10058.346207496526;10079.992000799935;10108.646197383094;8315.792105197357;10069.295149339549;10073.89926100737;10082.848757268646;10098.990100989879;10074.194064474825;10186;10189.643362482277;10208.489575521195;10210.795784084277;42696.57303426957;43000.1399972002;43054.56945430537;43304.13391732179;43380.915477113325;2892.913212603625;3533.699635530983;3591.1381268495634;3622.855085796565;3908.9804550977346;32171.356572868644;32462.837685811657;32567;32641.510377344122;32794.50808237879;3352.245744707421;3361.7142542883885;3381.6618338165986;3463.6016858061394;3489.59869614995;464734;543442;544848.2757586227;547891;549068;35021.29957400838;61498.770024600155;61911.76176476445;62033.37966620366;62118.37881621126;35421.822890885895;35927.461088083175;36902.81548592293;37006.629933700315;37081.629183708355;15845.366185352457;15968.680626387408;15976;16012;16054.43809466663;13262.469501220035;13335.333233338295;13394.464221431228;13394.732105357838;13433;8125.674973001132;8136.1050284468665;8176.427650064557;8193.59032048407;8202.58987050645;3425.811580363054;3445.6898879101;3453.0849324928913;3456.3087382523595;3466.3240668069484;844.3203221406703;945.7635591102224;978.4227305889559;984.7095106943469;998.9250806189565;22878.885605571864;24218.63672044921;26472.867635662085;28994.710052899623;31254.374912501622;995.0795514149528;1049.2602715085845;1059.9152067834555;1086.32104934416;1159.1016961854461;15974.281157347947;16562.340890712538;16660.833391666172;16665.750013749803;16684.33262669504;626731;769229;769295;771635;773381;60326;60717.69641151766;61001;61118.69440652857;61122.777544448865;1396.3158052554174;1422.4239183130849;1436.7916652085598;1439.7048605035943;1444.9855501444852;30069.849650751607;32159.678403216603;32562.348753024333;32603.34793304168;34246;57555;58627;58719.4128058714;58724.825503490545;61423.69288153531;574820;578731;579996;580583;582027;34774.47838282377;36893;44422.777886110365;44470.332945005204;44492.33261501145;48344.7582762098;48561;48634;48792.26811597758;49187.50812491829;32807;40070.799646001586;40310.79844600758;41234.38148427836;41327;40118.59881401266;40176.59823401846;40252.39621405623;41195.58804411918;41394.37908431316;32792.836035819666;39527;39931.2013759729;40525;41912;32980.340393192484;36436.76552881921;36483.452748209325;36761.63238367689;36973;27212.455750885267;27280.59079113775;27368;27456.039038633553;27595.448091037666 09:58:13 INFO - PROCESS | 1636 | |2;jquery.html;392.9783861887596;393.3804258293189;393.6653844232401;401.4580316572627;421.3090531528294;18104.72842907356;20626.278080267195;21576;22059.66910496344;22424.55150896981;20991.47521311964;21295;21582.352529424104;21660.56678866422;21696.566068678658;5900.704964751767;6159.692015399234;6161;6257.405546473078;6266.624002559838;5889.85275368115;6147.60040597362;6185.628862268279;6192.752289908398;6208.410201030895;6214.689265536727;6271.278802937675;6276.089966954789;6292.2134733158355;6310.5582609217145;5984.132300816379;6220.035894436347;6238.906416403757;6251.281102673205;6255;5852.648841069549;5949.2266005419015;5994.950883595397;6131.3868613138775;6143.232095988002;13658.521951731742;13822.239776812272;21020.948952552466;26019.82910769001;26743.598846017325;2232.218723446797;2239.787220214077;2303.2399308228246;2327.8603283803027;2432.1122790181635;10258.846117308247;10407.739806504822;10409.843852342221;10763.569457221702;10782;1870.710039943811;1936.1093896807345;1949.3469687654654;1953.1796645408963;1956.8825870447818;132901;135575;135676;135853;139905.300473497;11718.472668729928;11776.234544754563;11795.88204117965;11937.641870743892;12076.094292928066;14955;15002.849971500364;15091;15098.943073984716;15136.621584460476;7573.59888420644;8437.620307086074;8766.561671916379;8802.427842190365;8838.602262898185;8670.479771213748;8733;8744.344174186961;8823.514706691194;8868.201861832466;4666.300054991779;4674.929876051862;4702.130105930345;4706.647001474835;4717.056588682277;1947.4936516505811;1950.629380417716;1975;2012.3862222022424;2038.6636205026005;731.7694926098262;852.2146103912294;974.9658761943298;1011.5549158370294;1026.461107918349;14940.626484337978;19032.809671903382;20256.98715064241;21078.262260821106;22035.449113772283;802.4583406200908;865.9350548708873;881.823635272948;1006.5017816181037;1072.158355690779;11101.5559377624;11514.424278786028;11544.59593914209;11545.942270288595;11574.88425115755;541236;543627;543651;641677.791611039;651598;100494;112616.43691781652;136616;154660.2266988658;157654;861.6811779641573;1005.1456262177092;1053.4627340056472;1053.5417093564172;1056.6618682021833;15842.52472425829;19435.61128777388;19780.703289450958;19968.10143543515;20221.59556808885;40510.39234411427;47264.636768160766;57049;59034.11448828357;59628;87132;87136.56431718054;90763.54618227131;90890;92548.53725731328;7931.920680793349;8101.10887802353;8250.504969701837;8386.748397548083;8475.957620211859;9182.44905305657;13167.53913613019;13255.867441325849;13416.932915335361;13464.192148471124;11418.657440276806;11578.189526733047;11611.071114311004;11899.036658951176;11910.583129590423;9321.673741419017;11219.439028048402;11422.428878556206;11518.712032199262;11651.88348116508;11483.138764592522;11689.532418703157;11754.529818807152;11865.288082715064;11935.641930742091;8066.072401673882;8217.83564328698;8262.793430164294;8321.583920803814;8339.332853371594;8130.83738325242;10836.295640783324;11263.436828158396;11294.491747871201;11302.682949995396 09:58:13 INFO - PROCESS | 1636 | |3;mootools.html;1565.616423976126;1607.6463178100817;1844.926202951882;1966.8524860635448;1969.3501144622257;8539.316854651628;8774;8969.551522423877;9564.85652715209;9583.952080239598;9069.183773460387;9359.298052646045;9367.344285899973;9482.288828337867;9507.04929507049;2447.2413551798954;2476.4675594747127;2476.7647073527987;2479.38015496126;2487.253823852846;2429.161939130997;2484.5776218042975;2488.054539275073;2490.2653717153394;2500.8499490030567;2460.3849037740565;2473.072597775834;2486.8632225227607;2490.439651078511;2492.9405002873796;1756.5608597850537;2437.792787613055;2458.8770561471856;2466.938326541851;2565.6921169459597;2442.926712198637;2453.766892145243;2460.692413448319;2464.9014039438403;2471.6786817713582;8076.3942704297415;9325.580348884316;9483.525823708856;9497.240220782322;9596.472194029326;4872.196087645534;5492.203630473599;5606.55147588192;5724.79963201286;5743.82768516941;3325.584301962255;3623.0148449758326;3700.834237215269;3719.460678201646;3776.3013842438963;1110.4725255503652;1129.3675541696675;1137.2835113878205;1138.402338772143;1158.7972104881696;12503.312317822516;12610.180338278074;12646.367681615975;12649;12690.746185076247;4851.272309153655;4901.460839307673;4925.482824303396;5034.899302014012;5043.571296439771;10742.24804263694;10757.9462102689;10764.515596798163;10765.3540787553;10774.030337269684;5620.325560932714;5622.859428514238;5658.943410565924;5667.773289068391;5673.574481913791;4558.361829343895;4580.1755683976535;5017.071841709296;5048.419431765321;5156.484351564888;4096.852881193271;4128.401381799622;4193.35003074524;4225.260579398654;4252.851150209728;1314.6656144013643;1320.6632308761205;1329.9202047877159;1334.8264725585807;1342.9865701343058;896.7982204004047;918.8024574716468;928.6331898900032;936.5457752989795;942.8774259346241;5856.770078283608;5927.911081333784;6025.969870150621;6086.421789929949;6096.329403765582;439.18531124763103;1021.4075836015094;1060.1412855587;1079.6167360587035;1099.301943266032;3961.58403367648;4094.6519545838937;4124.876253712393;4127.607877251657;4137.565555616617;11271;11663.533458661559;11715.297082175097;11716.589919352953;11720.17958742897;11601.18791684574;11632.243904146204;11672.70818229534;11674.299542027506;11688.590899318484;8239.093699693029;8639.956800216085;8760.605772740115;8857.468551886908;8873.955630221937;6187.381261873957;6203.31763506005;6210;6238.875222495434;6239.906401404073;10481.277022275885;10541.73645658834;10697.197710171613;10816.56733730642;10870.456477176267;8966.775830604027;10991.61529346469;11015.944920275348;11053.944730276618;11086.944565277123;7281.199068102399;7465.776026719207;7536.321731044232;8000.319972802377;8123.268905798506;8754.387192896436;9080.636774528944;9115.179633832988;9126.5436728162;9133.40632858862;7830.725924592612;7839.960800195962;7903.84192316162;7949.642266097924;8081.959590202011;7836.921630783847;7922.286994170322;7944.364450843803;7954.482958607672;7965.362770978424;7247.456440766858;7347.963260183878;7382.667779950022;7427.554346739213;7445.664945077593;4101.2002659482305;4536.637069034536;4671.089137618132;5186.533212010937;5190.455002224863;4126.8761937141935;4518.706284091523;5316.893662126813;5394;5406.7837286509675 09:58:13 INFO - PROCESS | 1636 | |4;prototype.html;309.14675495632065;314.2317034849792;319.8624591425687;324.6445142568889;325.247053072138;4488.887777805557;4762.380890484233;5632.915506267399;5728.5914880646005;5742.79900203493;5427.592930530206;5566;5582.609217354787;5634;5665.320161580606;4297.226499230137;4322.956770432303;4326.740395576276;4360.324149756777;4370.606645401913;3781.394976803712;3877.4571559981623;4323.567643235683;4375.486886522988;4398.824047038131;3961.564227934925;3998.7800670963084;4256.3189889617515;4264.701470897038;4325.848595299165;3516.591135072471;3712.9443058354145;4175.492586227569;4309.375140604595;4329.502107257643;3179.459491886385;3218.983905080483;3753.530808648919;3758.830852611639;3773.6037716039696;4021.7586944783407;5208.609354298443;5287.973560132214;5493.395726470085;5528.391876893538;4382.824687012516;4938.851834444937;4944.90110197794;4961.5038496150455;4994.575461085812;4850.738807909934;4929.820265928492;5150.407703114152;5902.498287645512;6005.939940600581;3301.884434044821;3881.86413475527;4158.313878210122;4158.9376159357635;4196;5516.310461192391;6264.619444611064;6301.1493448384335;6330.873382532323;6345.556960570214;3803.7067397085125;3923.4114882767813;4258.467691538558;4262.190183865056;4270.551592082848;3438.6045604755273;3971.860984865516;4286.335617979218;4295.119500502389;4306.763128027926;4201.768902710381;4314.784260786948;4976.353074100344;4981.651284410129;5023.572996295283;4920.606351491872;4938.678985865908;5931.703414829241;5995.730192141364;6010.248718910137;1214.9444147967868;1216.2398500936915;1245.3586403002462;1446.8770154536983;1459.1026518690928;869.3219288954625;879.6305551668314;899.3884158772098;905.6241659711146;906.7869050773063;3921.647051765298;4132.359484279941;4366.607005369532;4587.036722288357;4660.877212267788;4678.105367326239;4840.661153719277;5114.693118412907;5131.538161565477;5148.9485105149215;4351.3472979053395;4445.888852778642;4627.722336659811;4630.3748993886065;4669.4630117536235;2350.74141844397;2376.762323767644;2610.569256072765;2727.4317267570827;2732.43984983078;4570.588647021717;5032.748362581856;5268.443800434691;5272.653669117206;5342.813001545005;4330.505975438468;4738;4771.544678872977;5161.483851614884;5192.221166825007;5841.4450627190345;5916.319623243382;6240.344763799736;6316.905246421399;6372.713227904663;5159.793608255628;6223.253209614875;6258.249010118815;6261.872862884725;6276.843078923063;4863.978564501353;5646.971765141148;5907.793227237026;5912.67480288571;6084.543659225665;6465.2564955030775;6477.935220647733;6478.805635830932;6490.902636460362;6533.281339052795;4035.29382358092;4040.717149799486;4074.329524894779;4089.221188782889;4094.447249621263;5222.738863056908;5917.940820591911;5927.525797936241;6161.938380616137;6249.812505624656;4763;5139.871503212449;5951.404859514014;6061.848453788691;6067;5291.232771248225;5326.760295786777;5972.432618901197;6088.634681919099;6095.2685677718955;5244.501772331622;5753.70541628147;5867;5956.374580668968;5965.313988891333;6015.248093988252;6041.426064523863;6058.212432383762;6081.358033331065;6082.270127584541;4655.4180727409075;5644.745986430703;5962.37395073511;5985.581009329305;6044.909326360196 09:58:13 INFO - PROCESS | 1636 | |5;yui.html;624.6158612453341;788.8027993001746;793.091909763321;832.6919039955218;862.0948004595175;15269.312880920357;16097.597560060989;16402.26189821458;16430.507084787445;16434.83565164348;16038.117903515302;16576.58558536037;16589.004659720395;16640.66718665626;16647;754.7659576592256;852.4629483425433;889.5329951775306;926.763675262807;927.5686805635378;893.0399820193286;927.0081013315755;930.8231436027168;931.483026920059;935.2658163341778;947.0576776107782;954.9856752148723;957.5164541906328;958.9856152157688;959.6976952260015;888.5779254853958;932.2635118256569;946.6450081219542;950.0499500499501;954.1984732824426;680.618853442074;692.3007762160204;698.9790306290769;705.7212401101588;713.3294702979183;15302.311395987208;15563.610909727347;15698.607534811606;15726.68546629061;15854.445094421755;15387.615309617237;15497.225138743017;15506.922465387714;15559.455419060392;15564.455244066403;10676.946615266874;11860.991815695676;12323.445444955;12350.75298494034;12372.13395062346;3911.765294082336;3956.0505478685195;4026.9194616107807;4053.716239863211;4159.08500129974;100188.99433016949;100890.99109008962;111840.4407977963;131001.34499327537;135559;11367.317960922372;11524.94237528807;11569.247998880046;11926;11944.88055119455;23032;23047.308580742603;23249.18627848017;23285.41786455352;23392.94731737076;7929.286364227247;7979.281864632095;8020.919790802134;8053.234942680436;8174.959125204455;4366.951931536472;4385.780710964503;4427.800748966304;4453.576910193527;4475.507694153641;3582.498450216972;3688.3914154164263;3730.515033045687;3735.0475628714503;3738.1776009277914;674.8886433738477;680.1056610557101;688.18793823289;691.882379995402;692.4010730717893;516.5247971865817;541.3260490689039;585.9003969325225;607.8480379905023;654.711926752237;8905.955470222738;9297.39566928161;9401.153896149379;9432;9572.847055542863;635.6207030743299;637.5186734015789;654.8853950558729;657.2638644717947;684.8459096703202;4433.82264709408;4595.563421474954;4615.723056616614;4662.090892276042;4680.9297860532115;126857;180422;185446;187573;189189;91023;93902.53048734849;125253;127651;127818.36090819487;116219.2567111494;119176;119901.20395184269;120193.79806202001;125401;9321.627134914528;10001.539309495483;10583.417912014913;10596.523156458132;10625.149988000787;47249.29126063043;60222.09666855088;62881.427964301256;64707.67646161739;67871;95002;97407;98420.50789746005;101410.49294753774;103675;10641.496241915873;12198.878011219775;13008.349582520646;13295.66760830987;14108.858911410754;14719.92640036793;14984.47554335593;15766.527004189893;15799.605009874846;15967.361305547647;13644.931775341456;14673.051010108662;14919.328630211883;14923.776143358076;15470.922645386701;13475.595732128051;14538.927305363406;14602.196879171748;14679.41282348694;14960.625984350478;14165.858341416453;14205.715885682022;14451.638709031939;14499.13005219648;14830.18433986098;11404.543818247177;11719.941400292944;11841.407929603658;12077.637670869888;12166.878331216929;11805.881941180822;11928.880711192776;11945.462454189408;12191.390430478263;12225.816612750637 09:58:13 INFO - PROCESS | 1636 | __end_tp_report 09:58:13 INFO - PROCESS | 1636 | __start_cc_report 09:58:13 INFO - PROCESS | 1636 | _x_x_mozilla_cycle_collect,357 09:58:13 INFO - PROCESS | 1636 | __end_cc_report 09:58:13 INFO - PROCESS | 1636 | __startTimestamp1480010293439__endTimestamp 09:58:13 INFO - PROCESS | 1636 | 09:58:13 INFO - PROCESS | 1636 | ------- Summary: start ------- 09:58:13 INFO - PROCESS | 1636 | Number of tests: 6 09:58:13 INFO - PROCESS | 1636 | 09:58:13 INFO - PROCESS | 1636 | [#0] dojo.html Cycles:165 Average:5952.20 Median:6217.84 stddev:664.23 (10.7%) stddev-sans-first:639.18 09:58:13 INFO - PROCESS | 1636 | Values: 3558.6 3608.4 3630.5 3633.3 3636.6 5914.6 5931.6 5939.1 6075.0 6092.1 4350.9 6040.2 6046.2 6085.0 6089.3 5144.7 5371.5 5503.4 5507.4 5510.6 5467.3 5477.2 5490.6 5500.3 5518.9 5340.5 5373.8 5515.0 5519.5 5551.4 5410.5 5414.6 5484.0 5500.9 5566.7 4653.8 4718.5 4853.4 5436.5 5489.6 5837.1 6026.2 6032.5 6074.9 6140.7 5171.9 6237.8 6272.9 6315.9 6409.5 6152.0 6191.8 6385.1 6513.0 6543.0 6196.7 6225.3 6230.2 6232.1 6251.2 6373.8 6386.6 6478.5 6515.0 6522.5 6266.2 6346.1 6365.0 6368.5 6369.8 6462.5 6487.5 6490.7 6505.3 6519.8 6194.7 6278.0 6296.1 6316.2 6378.0 6371.0 6401.1 6413.5 6415.3 6418.1 5153.7 5164.5 5172.1 5178.5 5192.6 4527.6 4567.0 4599.9 4668.4 4698.1 6057.4 6116.8 6127.5 6147.0 6149.3 6470.5 6472.4 6492.6 6508.2 6526.9 5926.8 6059.1 6062.2 6105.8 6171.6 5690.1 5690.5 5703.2 5722.6 5760.5 6562.9 6655.5 6663.3 6671.1 6686.3 6236.6 6283.6 6289.1 6398.1 6451.0 6515.3 6669.6 6678.6 6680.9 6685.6 6349.6 6372.3 6377.9 6382.8 6394.0 6219.3 6269.4 6418.2 6469.3 6503.7 6094.0 6190.2 6259.2 6289.7 6316.6 6293.7 6297.7 6308.2 6309.2 6321.7 4961.7 6141.4 6212.9 6246.5 6303.9 6187.6 6188.4 6217.8 6259.1 6260.0 6248.6 6263.5 6268.7 6282.1 6291.8 09:58:13 INFO - PROCESS | 1636 | 09:58:13 INFO - PROCESS | 1636 | [#1] ext.html Cycles:180 Average:74272.37 Median:36897.91 stddev:167563.03 (454.1%) stddev-sans-first:167941.45 09:58:13 INFO - PROCESS | 1636 | Values: 464.0 495.7 534.6 546.2 561.9 32070.2 37629.6 41247.0 43453.8 45804.1 43917.6 44815.8 45132.8 45298.0 45465.8 10025.2 10170.6 10214.3 10215.7 10232.7 9937.5 10034.8 10060.7 10073.0 10105.0 8742.3 9972.7 10058.3 10080.0 10108.6 8315.8 10069.3 10073.9 10082.8 10099.0 10074.2 10186.0 10189.6 10208.5 10210.8 42696.6 43000.1 43054.6 43304.1 43380.9 2892.9 3533.7 3591.1 3622.9 3909.0 32171.4 32462.8 32567.0 32641.5 32794.5 3352.2 3361.7 3381.7 3463.6 3489.6 464734.0 543442.0 544848.3 547891.0 549068.0 35021.3 61498.8 61911.8 62033.4 62118.4 35421.8 35927.5 36902.8 37006.6 37081.6 15845.4 15968.7 15976.0 16012.0 16054.4 13262.5 13335.3 13394.5 13394.7 13433.0 8125.7 8136.1 8176.4 8193.6 8202.6 3425.8 3445.7 3453.1 3456.3 3466.3 844.3 945.8 978.4 984.7 998.9 22878.9 24218.6 26472.9 28994.7 31254.4 995.1 1049.3 1059.9 1086.3 1159.1 15974.3 16562.3 16660.8 16665.8 16684.3 626731.0 769229.0 769295.0 771635.0 773381.0 60326.0 60717.7 61001.0 61118.7 61122.8 1396.3 1422.4 1436.8 1439.7 1445.0 30069.8 32159.7 32562.3 32603.3 34246.0 57555.0 58627.0 58719.4 58724.8 61423.7 574820.0 578731.0 579996.0 580583.0 582027.0 34774.5 36893.0 44422.8 44470.3 44492.3 48344.8 48561.0 48634.0 48792.3 49187.5 32807.0 40070.8 40310.8 41234.4 41327.0 40118.6 40176.6 40252.4 41195.6 41394.4 32792.8 39527.0 39931.2 40525.0 41912.0 32980.3 36436.8 36483.5 36761.6 36973.0 27212.5 27280.6 27368.0 27456.0 27595.4 09:58:13 INFO - PROCESS | 1636 | 09:58:13 INFO - PROCESS | 1636 | [#2] jquery.html Cycles:180 Average:35593.77 Median:22047.56 stddev:98843.97 (448.3%) stddev-sans-first:99085.92 09:58:13 INFO - PROCESS | 1636 | Values: 393.0 393.4 393.7 401.5 421.3 18104.7 20626.3 21576.0 22059.7 22424.6 20991.5 21295.0 21582.4 21660.6 21696.6 5900.7 6159.7 6161.0 6257.4 6266.6 5889.9 6147.6 6185.6 6192.8 6208.4 6214.7 6271.3 6276.1 6292.2 6310.6 5984.1 6220.0 6238.9 6251.3 6255.0 5852.6 5949.2 5995.0 6131.4 6143.2 13658.5 13822.2 21020.9 26019.8 26743.6 2232.2 2239.8 2303.2 2327.9 2432.1 10258.8 10407.7 10409.8 10763.6 10782.0 1870.7 1936.1 1949.3 1953.2 1956.9 132901.0 135575.0 135676.0 135853.0 139905.3 11718.5 11776.2 11795.9 11937.6 12076.1 14955.0 15002.8 15091.0 15098.9 15136.6 7573.6 8437.6 8766.6 8802.4 8838.6 8670.5 8733.0 8744.3 8823.5 8868.2 4666.3 4674.9 4702.1 4706.6 4717.1 1947.5 1950.6 1975.0 2012.4 2038.7 731.8 852.2 975.0 1011.6 1026.5 14940.6 19032.8 20257.0 21078.3 22035.4 802.5 865.9 881.8 1006.5 1072.2 11101.6 11514.4 11544.6 11545.9 11574.9 541236.0 543627.0 543651.0 641677.8 651598.0 100494.0 112616.4 136616.0 154660.2 157654.0 861.7 1005.1 1053.5 1053.5 1056.7 15842.5 19435.6 19780.7 19968.1 20221.6 40510.4 47264.6 57049.0 59034.1 59628.0 87132.0 87136.6 90763.5 90890.0 92548.5 7931.9 8101.1 8250.5 8386.7 8476.0 9182.4 13167.5 13255.9 13416.9 13464.2 11418.7 11578.2 11611.1 11899.0 11910.6 9321.7 11219.4 11422.4 11518.7 11651.9 11483.1 11689.5 11754.5 11865.3 11935.6 8066.1 8217.8 8262.8 8321.6 8339.3 8130.8 10836.3 11263.4 11294.5 11302.7 09:58:13 INFO - PROCESS | 1636 | 09:58:13 INFO - PROCESS | 1636 | [#3] mootools.html Cycles:180 Average:6036.64 Median:2478.95 stddev:3469.37 (140.0%) stddev-sans-first:3462.83 09:58:13 INFO - PROCESS | 1636 | Values: 1565.6 1607.6 1844.9 1966.9 1969.4 8539.3 8774.0 8969.6 9564.9 9584.0 9069.2 9359.3 9367.3 9482.3 9507.0 2447.2 2476.5 2476.8 2479.4 2487.3 2429.2 2484.6 2488.1 2490.3 2500.8 2460.4 2473.1 2486.9 2490.4 2492.9 1756.6 2437.8 2458.9 2466.9 2565.7 2442.9 2453.8 2460.7 2464.9 2471.7 8076.4 9325.6 9483.5 9497.2 9596.5 4872.2 5492.2 5606.6 5724.8 5743.8 3325.6 3623.0 3700.8 3719.5 3776.3 1110.5 1129.4 1137.3 1138.4 1158.8 12503.3 12610.2 12646.4 12649.0 12690.7 4851.3 4901.5 4925.5 5034.9 5043.6 10742.2 10757.9 10764.5 10765.4 10774.0 5620.3 5622.9 5658.9 5667.8 5673.6 4558.4 4580.2 5017.1 5048.4 5156.5 4096.9 4128.4 4193.4 4225.3 4252.9 1314.7 1320.7 1329.9 1334.8 1343.0 896.8 918.8 928.6 936.5 942.9 5856.8 5927.9 6026.0 6086.4 6096.3 439.2 1021.4 1060.1 1079.6 1099.3 3961.6 4094.7 4124.9 4127.6 4137.6 11271.0 11663.5 11715.3 11716.6 11720.2 11601.2 11632.2 11672.7 11674.3 11688.6 8239.1 8640.0 8760.6 8857.5 8874.0 6187.4 6203.3 6210.0 6238.9 6239.9 10481.3 10541.7 10697.2 10816.6 10870.5 8966.8 10991.6 11015.9 11053.9 11086.9 7281.2 7465.8 7536.3 8000.3 8123.3 8754.4 9080.6 9115.2 9126.5 9133.4 7830.7 7840.0 7903.8 7949.6 8082.0 7836.9 7922.3 7944.4 7954.5 7965.4 7247.5 7348.0 7382.7 7427.6 7445.7 4101.2 4536.6 4671.1 5186.5 5190.5 4126.9 4518.7 5316.9 5394.0 5406.8 09:58:13 INFO - PROCESS | 1636 | 09:58:13 INFO - PROCESS | 1636 | [#4] prototype.html Cycles:180 Average:4635.85 Median:4953.20 stddev:1473.46 (29.7%) stddev-sans-first:1441.36 09:58:13 INFO - PROCESS | 1636 | Values: 309.1 314.2 319.9 324.6 325.2 4488.9 4762.4 5632.9 5728.6 5742.8 5427.6 5566.0 5582.6 5634.0 5665.3 4297.2 4323.0 4326.7 4360.3 4370.6 3781.4 3877.5 4323.6 4375.5 4398.8 3961.6 3998.8 4256.3 4264.7 4325.8 3516.6 3712.9 4175.5 4309.4 4329.5 3179.5 3219.0 3753.5 3758.8 3773.6 4021.8 5208.6 5288.0 5493.4 5528.4 4382.8 4938.9 4944.9 4961.5 4994.6 4850.7 4929.8 5150.4 5902.5 6005.9 3301.9 3881.9 4158.3 4158.9 4196.0 5516.3 6264.6 6301.1 6330.9 6345.6 3803.7 3923.4 4258.5 4262.2 4270.6 3438.6 3971.9 4286.3 4295.1 4306.8 4201.8 4314.8 4976.4 4981.7 5023.6 4920.6 4938.7 5931.7 5995.7 6010.2 1214.9 1216.2 1245.4 1446.9 1459.1 869.3 879.6 899.4 905.6 906.8 3921.6 4132.4 4366.6 4587.0 4660.9 4678.1 4840.7 5114.7 5131.5 5148.9 4351.3 4445.9 4627.7 4630.4 4669.5 2350.7 2376.8 2610.6 2727.4 2732.4 4570.6 5032.7 5268.4 5272.7 5342.8 4330.5 4738.0 4771.5 5161.5 5192.2 5841.4 5916.3 6240.3 6316.9 6372.7 5159.8 6223.3 6258.2 6261.9 6276.8 4864.0 5647.0 5907.8 5912.7 6084.5 6465.3 6477.9 6478.8 6490.9 6533.3 4035.3 4040.7 4074.3 4089.2 4094.4 5222.7 5917.9 5927.5 6161.9 6249.8 4763.0 5139.9 5951.4 6061.8 6067.0 5291.2 5326.8 5972.4 6088.6 6095.3 5244.5 5753.7 5867.0 5956.4 5965.3 6015.2 6041.4 6058.2 6081.4 6082.3 4655.4 5644.7 5962.4 5985.6 6044.9 09:58:13 INFO - PROCESS | 1636 | 09:58:13 INFO - PROCESS | 1636 | [#5] yui.html Cycles:180 Average:26121.64 Median:23148.25 stddev:42439.95 (183.3%) stddev-sans-first:42515.82 09:58:13 INFO - PROCESS | 1636 | Values: 624.6 788.8 793.1 832.7 862.1 15269.3 16097.6 16402.3 16430.5 16434.8 16038.1 16576.6 16589.0 16640.7 16647.0 754.8 852.5 889.5 926.8 927.6 893.0 927.0 930.8 931.5 935.3 947.1 955.0 957.5 959.0 959.7 888.6 932.3 946.6 950.0 954.2 680.6 692.3 699.0 705.7 713.3 15302.3 15563.6 15698.6 15726.7 15854.4 15387.6 15497.2 15506.9 15559.5 15564.5 10676.9 11861.0 12323.4 12350.8 12372.1 3911.8 3956.1 4026.9 4053.7 4159.1 100189.0 100891.0 111840.4 131001.3 135559.0 11367.3 11524.9 11569.2 11926.0 11944.9 23032.0 23047.3 23249.2 23285.4 23392.9 7929.3 7979.3 8020.9 8053.2 8175.0 4367.0 4385.8 4427.8 4453.6 4475.5 3582.5 3688.4 3730.5 3735.0 3738.2 674.9 680.1 688.2 691.9 692.4 516.5 541.3 585.9 607.8 654.7 8906.0 9297.4 9401.2 9432.0 9572.8 635.6 637.5 654.9 657.3 684.8 4433.8 4595.6 4615.7 4662.1 4680.9 126857.0 180422.0 185446.0 187573.0 189189.0 91023.0 93902.5 125253.0 127651.0 127818.4 116219.3 119176.0 119901.2 120193.8 125401.0 9321.6 10001.5 10583.4 10596.5 10625.1 47249.3 60222.1 62881.4 64707.7 67871.0 95002.0 97407.0 98420.5 101410.5 103675.0 10641.5 12198.9 13008.3 13295.7 14108.9 14719.9 14984.5 15766.5 15799.6 15967.4 13644.9 14673.1 14919.3 14923.8 15470.9 13475.6 14538.9 14602.2 14679.4 14960.6 14165.9 14205.7 14451.6 14499.1 14830.2 11404.5 11719.9 11841.4 12077.6 12166.9 11805.9 11928.9 11945.5 12191.4 12225.8 09:58:13 INFO - PROCESS | 1636 | -------- Summary: end -------- 09:58:13 INFO - PROCESS | 1636 | 09:58:14 INFO - TEST-INFO | 1636: exit 0 09:58:14 INFO - TEST-OK | dromaeo_css | took 1112434ms 09:58:14 INFO - TEST-START | kraken 09:58:14 INFO - operating with platform_type : mac_ 09:58:14 INFO - Initialising browser for kraken test... 09:58:14 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/tmpGVfmHG/profile http://localhost:49236/getInfo.html) 09:58:16 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 09:58:16 INFO - PROCESS | 1648 | colorDepth:24 09:58:16 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 09:58:16 INFO - PROCESS | 1648 | __metrics 09:58:16 ERROR - PROCESS | 1648 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3015: TypeError: this.tabs is undefined 09:58:17 INFO - TEST-INFO | 1648: exit 0 09:58:17 INFO - Browser initialized. 09:58:17 INFO - Running cycle 1/1 for kraken test... 09:58:17 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/tmpGVfmHG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:58:29 INFO - PROCESS | 1651 | RSS: Main: 174743552 09:58:29 INFO - PROCESS | 1651 | 09:58:32 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection) 09:58:33 INFO - PROCESS | 1651 | RSS: Main: 187080704 09:58:33 INFO - PROCESS | 1651 | 09:58:35 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-dft) 09:58:36 INFO - PROCESS | 1651 | RSS: Main: 194560000 09:58:36 INFO - PROCESS | 1651 | 09:58:39 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-fft) 09:58:40 INFO - PROCESS | 1651 | RSS: Main: 198180864 09:58:40 INFO - PROCESS | 1651 | 09:58:42 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator) 09:58:42 INFO - PROCESS | 1651 | RSS: Main: 199106560 09:58:42 INFO - PROCESS | 1651 | 09:58:44 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:58:45 INFO - PROCESS | 1651 | RSS: Main: 199213056 09:58:45 INFO - PROCESS | 1651 | 09:58:48 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom) 09:58:48 INFO - PROCESS | 1651 | RSS: Main: 199786496 09:58:48 INFO - PROCESS | 1651 | 09:58:51 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate) 09:58:52 INFO - PROCESS | 1651 | RSS: Main: 199790592 09:58:52 INFO - PROCESS | 1651 | 09:58:55 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial) 09:58:56 INFO - PROCESS | 1651 | RSS: Main: 200171520 09:58:56 INFO - PROCESS | 1651 | 09:58:57 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:58:58 INFO - PROCESS | 1651 | RSS: Main: 200261632 09:58:58 INFO - PROCESS | 1651 | 09:59:00 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:59:01 INFO - PROCESS | 1651 | RSS: Main: 200331264 09:59:01 INFO - PROCESS | 1651 | 09:59:03 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:59:03 INFO - PROCESS | 1651 | RSS: Main: 200327168 09:59:03 INFO - PROCESS | 1651 | 09:59:06 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:59:07 INFO - PROCESS | 1651 | RSS: Main: 200753152 09:59:07 INFO - PROCESS | 1651 | 09:59:10 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:59:11 INFO - PROCESS | 1651 | RSS: Main: 200736768 09:59:11 INFO - PROCESS | 1651 | 09:59:12 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49236/tests/kraken/driver.html?testName=ai-astar) 09:59:13 INFO - PROCESS | 1651 | RSS: Main: 202432512 09:59:13 INFO - PROCESS | 1651 | 09:59:13 INFO - PROCESS | 1651 | __start_tp_report 09:59:13 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 09:59:13 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 09:59:13 INFO - PROCESS | 1651 | |i|pagename|runs| 09:59:13 INFO - PROCESS | 1651 | |0;ai-astar;107;115;116;118;116;125;172;166;116;116 09:59:13 INFO - PROCESS | 1651 | |1;audio-beat-detection;137;125;108;141;108;110;107;108;139;143 09:59:13 INFO - PROCESS | 1651 | |2;audio-dft;201;199;194;195;198;193;193;192;198;201 09:59:13 INFO - PROCESS | 1651 | |3;audio-fft;80;60;58;82;65;84;82;83;87;58 09:59:13 INFO - PROCESS | 1651 | |4;audio-oscillator;83;69;87;73;66;71;108;62;65;96 09:59:13 INFO - PROCESS | 1651 | |5;imaging-gaussian-blur;136;132;89;85;89;89;89;73;134;131 09:59:13 INFO - PROCESS | 1651 | |6;imaging-darkroom;136;99;153;155;95;94;95;95;124;103 09:59:13 INFO - PROCESS | 1651 | |7;imaging-desaturate;112;150;79;79;75;76;149;151;88;146 09:59:13 INFO - PROCESS | 1651 | |8;json-parse-financial;55;54;53;54;83;90;89;88;66;57 09:59:13 INFO - PROCESS | 1651 | |9;json-stringify-tinderbox;64;81;97;103;87;79;75;58;92;98 09:59:13 INFO - PROCESS | 1651 | |10;stanford-crypto-aes;80;85;89;91;84;85;81;88;90;85 09:59:13 INFO - PROCESS | 1651 | |11;stanford-crypto-ccm;153;141;124;154;149;139;150;158;212;158 09:59:13 INFO - PROCESS | 1651 | |12;stanford-crypto-pbkdf2;162;162;160;162;161;163;163;160;162;164 09:59:13 INFO - PROCESS | 1651 | |13;stanford-crypto-sha256-iterative;70;65;75;65;63;64;67;64;79;82 09:59:13 INFO - PROCESS | 1651 | __end_tp_report 09:59:13 INFO - PROCESS | 1651 | __start_cc_report 09:59:13 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,902 09:59:13 INFO - PROCESS | 1651 | __end_cc_report 09:59:13 INFO - PROCESS | 1651 | __startTimestamp1480010353042__endTimestamp 09:59:13 INFO - PROCESS | 1651 | 09:59:13 INFO - PROCESS | 1651 | ------- Summary: start ------- 09:59:13 INFO - PROCESS | 1651 | Number of tests: 14 09:59:13 INFO - PROCESS | 1651 | 09:59:13 INFO - PROCESS | 1651 | [#0] ai-astar Cycles:10 Average:126.70 Median:117.00 stddev:22.75 (19.4%) stddev-sans-first:22.99 09:59:13 INFO - PROCESS | 1651 | Values: 107.0 115.0 116.0 118.0 116.0 125.0 172.0 166.0 116.0 116.0 09:59:13 INFO - PROCESS | 1651 | 09:59:13 INFO - PROCESS | 1651 | [#1] audio-beat-detection Cycles:10 Average:122.60 Median:131.00 stddev:15.91 (12.1%) stddev-sans-first:16.00 09:59:13 INFO - PROCESS | 1651 | Values: 137.0 125.0 108.0 141.0 108.0 110.0 107.0 108.0 139.0 143.0 09:59:13 INFO - PROCESS | 1651 | 09:59:13 INFO - PROCESS | 1651 | [#2] audio-dft Cycles:10 Average:196.40 Median:198.00 stddev:3.41 (1.7%) stddev-sans-first:3.18 09:59:13 INFO - PROCESS | 1651 | Values: 201.0 199.0 194.0 195.0 198.0 193.0 193.0 192.0 198.0 201.0 09:59:13 INFO - PROCESS | 1651 | 09:59:13 INFO - PROCESS | 1651 | [#3] audio-fft Cycles:10 Average:73.90 Median:82.00 stddev:12.03 (14.7%) stddev-sans-first:12.56 09:59:13 INFO - PROCESS | 1651 | Values: 80.0 60.0 58.0 82.0 65.0 84.0 82.0 83.0 87.0 58.0 09:59:13 INFO - PROCESS | 1651 | 09:59:13 INFO - PROCESS | 1651 | [#4] audio-oscillator Cycles:10 Average:78.00 Median:72.00 stddev:15.11 (21.0%) stddev-sans-first:15.91 09:59:13 INFO - PROCESS | 1651 | Values: 83.0 69.0 87.0 73.0 66.0 71.0 108.0 62.0 65.0 96.0 09:59:13 INFO - PROCESS | 1651 | 09:59:13 INFO - PROCESS | 1651 | [#5] imaging-gaussian-blur Cycles:10 Average:104.70 Median:87.00 stddev:25.06 (28.8%) stddev-sans-first:23.89 09:59:13 INFO - PROCESS | 1651 | Values: 136.0 132.0 89.0 85.0 89.0 89.0 89.0 73.0 134.0 131.0 09:59:13 INFO - PROCESS | 1651 | 09:59:13 INFO - PROCESS | 1651 | [#6] imaging-darkroom Cycles:10 Average:114.90 Median:94.50 stddev:24.96 (26.4%) stddev-sans-first:25.28 09:59:13 INFO - PROCESS | 1651 | Values: 136.0 99.0 153.0 155.0 95.0 94.0 95.0 95.0 124.0 103.0 09:59:13 INFO - PROCESS | 1651 | 09:59:13 INFO - PROCESS | 1651 | [#7] imaging-desaturate Cycles:10 Average:110.50 Median:75.50 stddev:34.78 (46.1%) stddev-sans-first:36.88 09:59:13 INFO - PROCESS | 1651 | Values: 112.0 150.0 79.0 79.0 75.0 76.0 149.0 151.0 88.0 146.0 09:59:13 INFO - PROCESS | 1651 | 09:59:13 INFO - PROCESS | 1651 | [#8] json-parse-financial Cycles:10 Average:68.90 Median:74.50 stddev:16.51 (22.2%) stddev-sans-first:16.73 09:59:13 INFO - PROCESS | 1651 | Values: 55.0 54.0 53.0 54.0 83.0 90.0 89.0 88.0 66.0 57.0 09:59:13 INFO - PROCESS | 1651 | 09:59:13 INFO - PROCESS | 1651 | [#9] json-stringify-tinderbox Cycles:10 Average:83.40 Median:84.00 stddev:14.86 (17.7%) stddev-sans-first:14.00 09:59:13 INFO - PROCESS | 1651 | Values: 64.0 81.0 97.0 103.0 87.0 79.0 75.0 58.0 92.0 98.0 09:59:13 INFO - PROCESS | 1651 | 09:59:13 INFO - PROCESS | 1651 | [#10] stanford-crypto-aes Cycles:10 Average:85.80 Median:86.50 stddev:3.68 (4.2%) stddev-sans-first:3.24 09:59:13 INFO - PROCESS | 1651 | Values: 80.0 85.0 89.0 91.0 84.0 85.0 81.0 88.0 90.0 85.0 09:59:13 INFO - PROCESS | 1651 | 09:59:13 INFO - PROCESS | 1651 | [#11] stanford-crypto-ccm Cycles:10 Average:153.80 Median:153.50 stddev:22.93 (14.9%) stddev-sans-first:24.32 09:59:13 INFO - PROCESS | 1651 | Values: 153.0 141.0 124.0 154.0 149.0 139.0 150.0 158.0 212.0 158.0 09:59:13 INFO - PROCESS | 1651 | 09:59:13 INFO - PROCESS | 1651 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.90 Median:162.00 stddev:1.29 (0.8%) stddev-sans-first:1.36 09:59:13 INFO - PROCESS | 1651 | Values: 162.0 162.0 160.0 162.0 161.0 163.0 163.0 160.0 162.0 164.0 09:59:13 INFO - PROCESS | 1651 | 09:59:13 INFO - PROCESS | 1651 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:68.50 stddev:6.88 (10.0%) stddev-sans-first:7.30 09:59:13 INFO - PROCESS | 1651 | Values: 70.0 65.0 75.0 65.0 63.0 64.0 67.0 64.0 79.0 82.0 09:59:13 INFO - PROCESS | 1651 | -------- Summary: end -------- 09:59:13 INFO - PROCESS | 1651 | 09:59:13 INFO - TEST-INFO | 1651: exit 0 09:59:13 INFO - TEST-OK | kraken | took 59734ms 09:59:13 INFO - SUITE-END | took 1172s 09:59:14 INFO - Completed test suite (00:19:32) 09:59:14 INFO - javascript benchmark 09:59:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7562.905832714843, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3558.626344233857, 3608.4046132388157, 3630.546181727285, 3633.3459977204093, 3636.599974002859, 5914.585978981473, 5931.614445061074, 5939.07944268639, 6075.027995520718, 6092.147099406086, 4350.934735978963, 6040.244969378828, 6046.153538504613, 6084.969575152118, 6089.29973053099, 5144.717040562768, 5371.4897084776985, 5503.422140675211, 5507.421720719327, 5510.559155267589, 5467.316585426822, 5477.178423236506, 5490.6431081979745, 5500.312460942382, 5518.889622207554, 5340.465953404668, 5373.785048598052, 5515.007298686235, 5519.475649813261, 5551.3893471718075, 5410.48600382963, 5414.593905457087, 5484.0, 5500.889982200333, 5566.749496272637, 4653.7905794239, 4718.457377401608, 4853.39332583427, 5436.537894278991, 5489.615726899118, 5837.09525023622, 6026.156338112668, 6032.517398608101, 6074.9392506075255, 6140.662263575501, 5171.896562068775, 6237.750489980395, 6272.905906411407, 6315.905261421037, 6409.519286053518, 6152.046432802923, 6191.845203869894, 6385.138006369174, 6512.9579267317, 6542.967285163591, 6196.659183744938, 6225.346338634424, 6230.190075290274, 6232.0963460298, 6251.249850018027, 6373.840653983595, 6386.616802991835, 6478.514111441661, 6515.0, 6522.510811689142, 6266.185395898595, 6346.143270658495, 6365.013422919455, 6368.458681012074, 6369.840753981095, 6462.48300135988, 6487.513436492188, 6490.675466226669, 6505.316941721146, 6519.8044058678315, 6194.690265486708, 6277.96861015692, 6296.087067375205, 6316.178896743394, 6378.011408231731, 6370.968145159244, 6401.103845461639, 6413.4869210463985, 6415.26224484181, 6418.101465794793, 5153.7165455900285, 5164.509371609691, 5172.086328058643, 5178.482151784791, 5192.558632516203, 4527.59251667345, 4566.995261042632, 4599.862004139881, 4668.393108895822, 4698.060387922429, 6057.3639767824625, 6116.831988692009, 6127.479164271087, 6147.0, 6149.2620885494025, 6470.4823614110755, 6472.352764723584, 6492.642904640195, 6508.153939987771, 6526.869462610816, 5926.7925622603, 6059.091136329585, 6062.242219722535, 6105.778844231171, 6171.59884607499, 5690.118031705092, 5690.487856092972, 5703.17303990919, 5722.62802917809, 5760.53915686744, 6562.868742625216, 6655.500837437212, 6663.26704062543, 6671.099401580822, 6686.297938716365, 6236.6258024518675, 6283.560150789401, 6289.119523266655, 6398.072279519351, 6450.967745161244, 6515.28331883502, 6669.599824010575, 6678.599284042973, 6680.933190668031, 6685.598864068172, 6349.555531112777, 6372.299047104908, 6377.93622063792, 6382.840428989312, 6394.0408938659575, 6219.284782250099, 6269.40440658155, 6418.19772528434, 6469.320721324193, 6503.707333170113, 6094.0, 6190.164327815687, 6259.186305780219, 6289.685515724287, 6316.589421687576, 6293.653849038347, 6297.748090076529, 6308.179936608211, 6309.242890853127, 6321.715522801393, 4961.70229786214, 6141.416565426277, 6212.9068063979985, 6246.531510136667, 6303.873922521616, 6187.597806142587, 6188.44304012641, 6217.844553886189, 6259.12372267892, 6260.0, 6248.625082495065, 6263.530235232284, 6268.749250029948, 6282.057691346335, 6291.842703932255], "value": 5912.40437978377, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [463.9953600463994, 495.74469148388584, 534.5803544217789, 546.1534621336926, 561.8791959728659, 32070.198245043855, 37629.62370376302, 41247.0, 43453.78273108638, 45804.083918321616, 43917.560824391745, 44815.77592112035, 45132.77433612827, 45298.0, 45465.7726711366, 10025.248106392031, 10170.64402745904, 10214.28500005, 10215.744606384826, 10232.74418139545, 9937.453440060794, 10034.84947725781, 10060.69817905464, 10073.0, 10105.0, 8742.344324175712, 9972.700818975407, 10058.346207496526, 10079.992000799935, 10108.646197383094, 8315.792105197357, 10069.295149339549, 10073.89926100737, 10082.848757268646, 10098.990100989879, 10074.194064474825, 10186.0, 10189.643362482277, 10208.489575521195, 10210.795784084277, 42696.57303426957, 43000.1399972002, 43054.56945430537, 43304.13391732179, 43380.915477113325, 2892.913212603625, 3533.699635530983, 3591.1381268495634, 3622.855085796565, 3908.9804550977346, 32171.356572868644, 32462.837685811657, 32567.0, 32641.510377344122, 32794.50808237879, 3352.245744707421, 3361.7142542883885, 3381.6618338165986, 3463.6016858061394, 3489.59869614995, 464734.0, 543442.0, 544848.2757586227, 547891.0, 549068.0, 35021.29957400838, 61498.770024600155, 61911.76176476445, 62033.37966620366, 62118.37881621126, 35421.822890885895, 35927.461088083175, 36902.81548592293, 37006.629933700315, 37081.629183708355, 15845.366185352457, 15968.680626387408, 15976.0, 16012.0, 16054.43809466663, 13262.469501220035, 13335.333233338295, 13394.464221431228, 13394.732105357838, 13433.0, 8125.674973001132, 8136.1050284468665, 8176.427650064557, 8193.59032048407, 8202.58987050645, 3425.811580363054, 3445.6898879101, 3453.0849324928913, 3456.3087382523595, 3466.3240668069484, 844.3203221406703, 945.7635591102224, 978.4227305889559, 984.7095106943469, 998.9250806189565, 22878.885605571864, 24218.63672044921, 26472.867635662085, 28994.710052899623, 31254.374912501622, 995.0795514149528, 1049.2602715085845, 1059.9152067834555, 1086.32104934416, 1159.1016961854461, 15974.281157347947, 16562.340890712538, 16660.833391666172, 16665.750013749803, 16684.33262669504, 626731.0, 769229.0, 769295.0, 771635.0, 773381.0, 60326.0, 60717.69641151766, 61001.0, 61118.69440652857, 61122.777544448865, 1396.3158052554174, 1422.4239183130849, 1436.7916652085598, 1439.7048605035943, 1444.9855501444852, 30069.849650751607, 32159.678403216603, 32562.348753024333, 32603.34793304168, 34246.0, 57555.0, 58627.0, 58719.4128058714, 58724.825503490545, 61423.69288153531, 574820.0, 578731.0, 579996.0, 580583.0, 582027.0, 34774.47838282377, 36893.0, 44422.777886110365, 44470.332945005204, 44492.33261501145, 48344.7582762098, 48561.0, 48634.0, 48792.26811597758, 49187.50812491829, 32807.0, 40070.799646001586, 40310.79844600758, 41234.38148427836, 41327.0, 40118.59881401266, 40176.59823401846, 40252.39621405623, 41195.58804411918, 41394.37908431316, 32792.836035819666, 39527.0, 39931.2013759729, 40525.0, 41912.0, 32980.340393192484, 36436.76552881921, 36483.452748209325, 36761.63238367689, 36973.0, 27212.455750885267, 27280.59079113775, 27368.0, 27456.039038633553, 27595.448091037666], "value": 19701.414723884096, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.9783861887596, 393.3804258293189, 393.6653844232401, 401.4580316572627, 421.3090531528294, 18104.72842907356, 20626.278080267195, 21576.0, 22059.66910496344, 22424.55150896981, 20991.47521311964, 21295.0, 21582.352529424104, 21660.56678866422, 21696.566068678658, 5900.704964751767, 6159.692015399234, 6161.0, 6257.405546473078, 6266.624002559838, 5889.85275368115, 6147.60040597362, 6185.628862268279, 6192.752289908398, 6208.410201030895, 6214.689265536727, 6271.278802937675, 6276.089966954789, 6292.2134733158355, 6310.5582609217145, 5984.132300816379, 6220.035894436347, 6238.906416403757, 6251.281102673205, 6255.0, 5852.648841069549, 5949.2266005419015, 5994.950883595397, 6131.3868613138775, 6143.232095988002, 13658.521951731742, 13822.239776812272, 21020.948952552466, 26019.82910769001, 26743.598846017325, 2232.218723446797, 2239.787220214077, 2303.2399308228246, 2327.8603283803027, 2432.1122790181635, 10258.846117308247, 10407.739806504822, 10409.843852342221, 10763.569457221702, 10782.0, 1870.710039943811, 1936.1093896807345, 1949.3469687654654, 1953.1796645408963, 1956.8825870447818, 132901.0, 135575.0, 135676.0, 135853.0, 139905.300473497, 11718.472668729928, 11776.234544754563, 11795.88204117965, 11937.641870743892, 12076.094292928066, 14955.0, 15002.849971500364, 15091.0, 15098.943073984716, 15136.621584460476, 7573.59888420644, 8437.620307086074, 8766.561671916379, 8802.427842190365, 8838.602262898185, 8670.479771213748, 8733.0, 8744.344174186961, 8823.514706691194, 8868.201861832466, 4666.300054991779, 4674.929876051862, 4702.130105930345, 4706.647001474835, 4717.056588682277, 1947.4936516505811, 1950.629380417716, 1975.0, 2012.3862222022424, 2038.6636205026005, 731.7694926098262, 852.2146103912294, 974.9658761943298, 1011.5549158370294, 1026.461107918349, 14940.626484337978, 19032.809671903382, 20256.98715064241, 21078.262260821106, 22035.449113772283, 802.4583406200908, 865.9350548708873, 881.823635272948, 1006.5017816181037, 1072.158355690779, 11101.5559377624, 11514.424278786028, 11544.59593914209, 11545.942270288595, 11574.88425115755, 541236.0, 543627.0, 543651.0, 641677.791611039, 651598.0, 100494.0, 112616.43691781652, 136616.0, 154660.2266988658, 157654.0, 861.6811779641573, 1005.1456262177092, 1053.4627340056472, 1053.5417093564172, 1056.6618682021833, 15842.52472425829, 19435.61128777388, 19780.703289450958, 19968.10143543515, 20221.59556808885, 40510.39234411427, 47264.636768160766, 57049.0, 59034.11448828357, 59628.0, 87132.0, 87136.56431718054, 90763.54618227131, 90890.0, 92548.53725731328, 7931.920680793349, 8101.10887802353, 8250.504969701837, 8386.748397548083, 8475.957620211859, 9182.44905305657, 13167.53913613019, 13255.867441325849, 13416.932915335361, 13464.192148471124, 11418.657440276806, 11578.189526733047, 11611.071114311004, 11899.036658951176, 11910.583129590423, 9321.673741419017, 11219.439028048402, 11422.428878556206, 11518.712032199262, 11651.88348116508, 11483.138764592522, 11689.532418703157, 11754.529818807152, 11865.288082715064, 11935.641930742091, 8066.072401673882, 8217.83564328698, 8262.793430164294, 8321.583920803814, 8339.332853371594, 8130.83738325242, 10836.295640783324, 11263.436828158396, 11294.491747871201, 11302.682949995396], "value": 9786.322553813701, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1565.616423976126, 1607.6463178100817, 1844.926202951882, 1966.8524860635448, 1969.3501144622257, 8539.316854651628, 8774.0, 8969.551522423877, 9564.85652715209, 9583.952080239598, 9069.183773460387, 9359.298052646045, 9367.344285899973, 9482.288828337867, 9507.04929507049, 2447.2413551798954, 2476.4675594747127, 2476.7647073527987, 2479.38015496126, 2487.253823852846, 2429.161939130997, 2484.5776218042975, 2488.054539275073, 2490.2653717153394, 2500.8499490030567, 2460.3849037740565, 2473.072597775834, 2486.8632225227607, 2490.439651078511, 2492.9405002873796, 1756.5608597850537, 2437.792787613055, 2458.8770561471856, 2466.938326541851, 2565.6921169459597, 2442.926712198637, 2453.766892145243, 2460.692413448319, 2464.9014039438403, 2471.6786817713582, 8076.3942704297415, 9325.580348884316, 9483.525823708856, 9497.240220782322, 9596.472194029326, 4872.196087645534, 5492.203630473599, 5606.55147588192, 5724.79963201286, 5743.82768516941, 3325.584301962255, 3623.0148449758326, 3700.834237215269, 3719.460678201646, 3776.3013842438963, 1110.4725255503652, 1129.3675541696675, 1137.2835113878205, 1138.402338772143, 1158.7972104881696, 12503.312317822516, 12610.180338278074, 12646.367681615975, 12649.0, 12690.746185076247, 4851.272309153655, 4901.460839307673, 4925.482824303396, 5034.899302014012, 5043.571296439771, 10742.24804263694, 10757.9462102689, 10764.515596798163, 10765.3540787553, 10774.030337269684, 5620.325560932714, 5622.859428514238, 5658.943410565924, 5667.773289068391, 5673.574481913791, 4558.361829343895, 4580.1755683976535, 5017.071841709296, 5048.419431765321, 5156.484351564888, 4096.852881193271, 4128.401381799622, 4193.35003074524, 4225.260579398654, 4252.851150209728, 1314.6656144013643, 1320.6632308761205, 1329.9202047877159, 1334.8264725585807, 1342.9865701343058, 896.7982204004047, 918.8024574716468, 928.6331898900032, 936.5457752989795, 942.8774259346241, 5856.770078283608, 5927.911081333784, 6025.969870150621, 6086.421789929949, 6096.329403765582, 439.18531124763103, 1021.4075836015094, 1060.1412855587, 1079.6167360587035, 1099.301943266032, 3961.58403367648, 4094.6519545838937, 4124.876253712393, 4127.607877251657, 4137.565555616617, 11271.0, 11663.533458661559, 11715.297082175097, 11716.589919352953, 11720.17958742897, 11601.18791684574, 11632.243904146204, 11672.70818229534, 11674.299542027506, 11688.590899318484, 8239.093699693029, 8639.956800216085, 8760.605772740115, 8857.468551886908, 8873.955630221937, 6187.381261873957, 6203.31763506005, 6210.0, 6238.875222495434, 6239.906401404073, 10481.277022275885, 10541.73645658834, 10697.197710171613, 10816.56733730642, 10870.456477176267, 8966.775830604027, 10991.61529346469, 11015.944920275348, 11053.944730276618, 11086.944565277123, 7281.199068102399, 7465.776026719207, 7536.321731044232, 8000.319972802377, 8123.268905798506, 8754.387192896436, 9080.636774528944, 9115.179633832988, 9126.5436728162, 9133.40632858862, 7830.725924592612, 7839.960800195962, 7903.84192316162, 7949.642266097924, 8081.959590202011, 7836.921630783847, 7922.286994170322, 7944.364450843803, 7954.482958607672, 7965.362770978424, 7247.456440766858, 7347.963260183878, 7382.667779950022, 7427.554346739213, 7445.664945077593, 4101.2002659482305, 4536.637069034536, 4671.089137618132, 5186.533212010937, 5190.455002224863, 4126.8761937141935, 4518.706284091523, 5316.893662126813, 5394.0, 5406.7837286509675], "value": 4816.748314815697, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.14675495632065, 314.2317034849792, 319.8624591425687, 324.6445142568889, 325.247053072138, 4488.887777805557, 4762.380890484233, 5632.915506267399, 5728.5914880646005, 5742.79900203493, 5427.592930530206, 5566.0, 5582.609217354787, 5634.0, 5665.320161580606, 4297.226499230137, 4322.956770432303, 4326.740395576276, 4360.324149756777, 4370.606645401913, 3781.394976803712, 3877.4571559981623, 4323.567643235683, 4375.486886522988, 4398.824047038131, 3961.564227934925, 3998.7800670963084, 4256.3189889617515, 4264.701470897038, 4325.848595299165, 3516.591135072471, 3712.9443058354145, 4175.492586227569, 4309.375140604595, 4329.502107257643, 3179.459491886385, 3218.983905080483, 3753.530808648919, 3758.830852611639, 3773.6037716039696, 4021.7586944783407, 5208.609354298443, 5287.973560132214, 5493.395726470085, 5528.391876893538, 4382.824687012516, 4938.851834444937, 4944.90110197794, 4961.5038496150455, 4994.575461085812, 4850.738807909934, 4929.820265928492, 5150.407703114152, 5902.498287645512, 6005.939940600581, 3301.884434044821, 3881.86413475527, 4158.313878210122, 4158.9376159357635, 4196.0, 5516.310461192391, 6264.619444611064, 6301.1493448384335, 6330.873382532323, 6345.556960570214, 3803.7067397085125, 3923.4114882767813, 4258.467691538558, 4262.190183865056, 4270.551592082848, 3438.6045604755273, 3971.860984865516, 4286.335617979218, 4295.119500502389, 4306.763128027926, 4201.768902710381, 4314.784260786948, 4976.353074100344, 4981.651284410129, 5023.572996295283, 4920.606351491872, 4938.678985865908, 5931.703414829241, 5995.730192141364, 6010.248718910137, 1214.9444147967868, 1216.2398500936915, 1245.3586403002462, 1446.8770154536983, 1459.1026518690928, 869.3219288954625, 879.6305551668314, 899.3884158772098, 905.6241659711146, 906.7869050773063, 3921.647051765298, 4132.359484279941, 4366.607005369532, 4587.036722288357, 4660.877212267788, 4678.105367326239, 4840.661153719277, 5114.693118412907, 5131.538161565477, 5148.9485105149215, 4351.3472979053395, 4445.888852778642, 4627.722336659811, 4630.3748993886065, 4669.4630117536235, 2350.74141844397, 2376.762323767644, 2610.569256072765, 2727.4317267570827, 2732.43984983078, 4570.588647021717, 5032.748362581856, 5268.443800434691, 5272.653669117206, 5342.813001545005, 4330.505975438468, 4738.0, 4771.544678872977, 5161.483851614884, 5192.221166825007, 5841.4450627190345, 5916.319623243382, 6240.344763799736, 6316.905246421399, 6372.713227904663, 5159.793608255628, 6223.253209614875, 6258.249010118815, 6261.872862884725, 6276.843078923063, 4863.978564501353, 5646.971765141148, 5907.793227237026, 5912.67480288571, 6084.543659225665, 6465.2564955030775, 6477.935220647733, 6478.805635830932, 6490.902636460362, 6533.281339052795, 4035.29382358092, 4040.717149799486, 4074.329524894779, 4089.221188782889, 4094.447249621263, 5222.738863056908, 5917.940820591911, 5927.525797936241, 6161.938380616137, 6249.812505624656, 4763.0, 5139.871503212449, 5951.404859514014, 6061.848453788691, 6067.0, 5291.232771248225, 5326.760295786777, 5972.432618901197, 6088.634681919099, 6095.2685677718955, 5244.501772331622, 5753.70541628147, 5867.0, 5956.374580668968, 5965.313988891333, 6015.248093988252, 6041.426064523863, 6058.212432383762, 6081.358033331065, 6082.270127584541, 4655.4180727409075, 5644.745986430703, 5962.37395073511, 5985.581009329305, 6044.909326360196], "value": 4170.251671422315, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [624.6158612453341, 788.8027993001746, 793.091909763321, 832.6919039955218, 862.0948004595175, 15269.312880920357, 16097.597560060989, 16402.26189821458, 16430.507084787445, 16434.83565164348, 16038.117903515302, 16576.58558536037, 16589.004659720395, 16640.66718665626, 16647.0, 754.7659576592256, 852.4629483425433, 889.5329951775306, 926.763675262807, 927.5686805635378, 893.0399820193286, 927.0081013315755, 930.8231436027168, 931.483026920059, 935.2658163341778, 947.0576776107782, 954.9856752148723, 957.5164541906328, 958.9856152157688, 959.6976952260015, 888.5779254853958, 932.2635118256569, 946.6450081219542, 950.0499500499501, 954.1984732824426, 680.618853442074, 692.3007762160204, 698.9790306290769, 705.7212401101588, 713.3294702979183, 15302.311395987208, 15563.610909727347, 15698.607534811606, 15726.68546629061, 15854.445094421755, 15387.615309617237, 15497.225138743017, 15506.922465387714, 15559.455419060392, 15564.455244066403, 10676.946615266874, 11860.991815695676, 12323.445444955, 12350.75298494034, 12372.13395062346, 3911.765294082336, 3956.0505478685195, 4026.9194616107807, 4053.716239863211, 4159.08500129974, 100188.99433016949, 100890.99109008962, 111840.4407977963, 131001.34499327537, 135559.0, 11367.317960922372, 11524.94237528807, 11569.247998880046, 11926.0, 11944.88055119455, 23032.0, 23047.308580742603, 23249.18627848017, 23285.41786455352, 23392.94731737076, 7929.286364227247, 7979.281864632095, 8020.919790802134, 8053.234942680436, 8174.959125204455, 4366.951931536472, 4385.780710964503, 4427.800748966304, 4453.576910193527, 4475.507694153641, 3582.498450216972, 3688.3914154164263, 3730.515033045687, 3735.0475628714503, 3738.1776009277914, 674.8886433738477, 680.1056610557101, 688.18793823289, 691.882379995402, 692.4010730717893, 516.5247971865817, 541.3260490689039, 585.9003969325225, 607.8480379905023, 654.711926752237, 8905.955470222738, 9297.39566928161, 9401.153896149379, 9432.0, 9572.847055542863, 635.6207030743299, 637.5186734015789, 654.8853950558729, 657.2638644717947, 684.8459096703202, 4433.82264709408, 4595.563421474954, 4615.723056616614, 4662.090892276042, 4680.9297860532115, 126857.0, 180422.0, 185446.0, 187573.0, 189189.0, 91023.0, 93902.53048734849, 125253.0, 127651.0, 127818.36090819487, 116219.2567111494, 119176.0, 119901.20395184269, 120193.79806202001, 125401.0, 9321.627134914528, 10001.539309495483, 10583.417912014913, 10596.523156458132, 10625.149988000787, 47249.29126063043, 60222.09666855088, 62881.427964301256, 64707.67646161739, 67871.0, 95002.0, 97407.0, 98420.50789746005, 101410.49294753774, 103675.0, 10641.496241915873, 12198.878011219775, 13008.349582520646, 13295.66760830987, 14108.858911410754, 14719.92640036793, 14984.47554335593, 15766.527004189893, 15799.605009874846, 15967.361305547647, 13644.931775341456, 14673.051010108662, 14919.328630211883, 14923.776143358076, 15470.922645386701, 13475.595732128051, 14538.927305363406, 14602.196879171748, 14679.41282348694, 14960.625984350478, 14165.858341416453, 14205.715885682022, 14451.638709031939, 14499.13005219648, 14830.18433986098, 11404.543818247177, 11719.941400292944, 11841.407929603658, 12077.637670869888, 12166.878331216929, 11805.881941180822, 11928.880711192776, 11945.462454189408, 12191.390430478263, 12225.816612750637], "value": 8171.317715243541, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1550.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 115.0, 116.0, 118.0, 116.0, 125.0, 172.0, 166.0, 116.0, 116.0], "value": 126.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 125.0, 108.0, 141.0, 108.0, 110.0, 107.0, 108.0, 139.0, 143.0], "value": 122.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [201.0, 199.0, 194.0, 195.0, 198.0, 193.0, 193.0, 192.0, 198.0, 201.0], "value": 196.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 60.0, 58.0, 82.0, 65.0, 84.0, 82.0, 83.0, 87.0, 58.0], "value": 73.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 69.0, 87.0, 73.0, 66.0, 71.0, 108.0, 62.0, 65.0, 96.0], "value": 78.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 132.0, 89.0, 85.0, 89.0, 89.0, 89.0, 73.0, 134.0, 131.0], "value": 104.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 99.0, 153.0, 155.0, 95.0, 94.0, 95.0, 95.0, 124.0, 103.0], "value": 114.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 150.0, 79.0, 79.0, 75.0, 76.0, 149.0, 151.0, 88.0, 146.0], "value": 110.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 53.0, 54.0, 83.0, 90.0, 89.0, 88.0, 66.0, 57.0], "value": 68.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 81.0, 97.0, 103.0, 87.0, 79.0, 75.0, 58.0, 92.0, 98.0], "value": 83.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 85.0, 89.0, 91.0, 84.0, 85.0, 81.0, 88.0, 90.0, 85.0], "value": 85.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 141.0, 124.0, 154.0, 149.0, 139.0, 150.0, 158.0, 212.0, 158.0], "value": 153.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 160.0, 162.0, 161.0, 163.0, 163.0, 160.0, 162.0, 164.0], "value": 161.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 65.0, 75.0, 65.0, 63.0, 64.0, 67.0, 64.0, 79.0, 82.0], "value": 69.4, "unit": "score"}]}]} 09:59:14 INFO - Return code: 0 09:59:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:59:14 ERROR - # TBPL SUCCESS # 09:59:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:59:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:59:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:59:14 INFO - 2016-11-24 09:59:14.344 screenresolution[1656:10339] starting screenresolution argv=screenresolution get 09:59:14 INFO - 2016-11-24 09:59:14.346 screenresolution[1656:10339] Display 0: 1600x1200x32@60 09:59:14 INFO - 2016-11-24 09:59:14.353 screenresolution[1657:10342] starting screenresolution argv=screenresolution list 09:59:14 INFO - Available Modes on Display 0 09:59:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:59:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:59:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:59:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:59:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:59:14 INFO - Intel Iris: 09:59:14 INFO - Chipset Model: Intel Iris 09:59:14 INFO - Type: GPU 09:59:14 INFO - Bus: Built-In 09:59:14 INFO - VRAM (Dynamic, Max): 1536 MB 09:59:14 INFO - Vendor: Intel (0x8086) 09:59:14 INFO - Device ID: 0x0a2e 09:59:14 INFO - Revision ID: 0x0009 09:59:14 INFO - Displays: 09:59:14 INFO - Display: 09:59:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:59:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:59:14 INFO - Display Serial Number: 1600x1200 60 09:59:14 INFO - Main Display: Yes 09:59:14 INFO - Mirror: Off 09:59:14 INFO - Online: Yes 09:59:14 INFO - Rotation: Supported 09:59:14 INFO - Return code: 0 09:59:14 INFO - Running post-action listener: _resource_record_post_action 09:59:14 INFO - [mozharness: 2016-11-24 17:59:14.586768Z] Finished run-tests step (success) 09:59:14 INFO - Running post-run listener: _resource_record_post_run 09:59:14 INFO - Total resource usage - Wall time: 1195s; CPU: 54.0%; Read bytes: 38790144; Write bytes: 498948096; Read time: 380; Write time: 1788 09:59:14 INFO - TinderboxPrint: CPU usage
54.2% 09:59:14 INFO - TinderboxPrint: I/O read bytes / time
38,790,144 / 380 09:59:14 INFO - TinderboxPrint: I/O write bytes / time
498,948,096 / 1,788 09:59:14 INFO - TinderboxPrint: CPU idle
2,188.7 (45.8%) 09:59:14 INFO - TinderboxPrint: CPU system
967.8 (20.2%) 09:59:14 INFO - TinderboxPrint: CPU user
1,625.1 (34.0%) 09:59:14 INFO - TinderboxPrint: Swap in / out
234,135,552 / 0 09:59:14 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 196217344; Write bytes: 195887104; Read time: 18070; Write time: 357 09:59:14 INFO - run-tests - Wall time: 1174s; CPU: 54.0%; Read bytes: 34604032; Write bytes: 297459712; Read time: 345; Write time: 1345 09:59:15 INFO - Running post-run listener: _upload_blobber_files 09:59:15 INFO - Blob upload gear active. 09:59:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:59:15 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 09:59:15 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:59:15 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:59:15 INFO - (blobuploader) - INFO - Open directory for files ... 09:59:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:59:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:59:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:59:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:59:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:59:16 INFO - (blobuploader) - INFO - Done attempting. 09:59:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:59:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:59:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:59:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:59:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:59:17 INFO - (blobuploader) - INFO - Done attempting. 09:59:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:59:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:59:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:59:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:59:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:59:19 INFO - (blobuploader) - INFO - Done attempting. 09:59:19 INFO - (blobuploader) - INFO - Iteration through files over. 09:59:19 INFO - Return code: 0 09:59:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:59:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:59:19 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fc3a837538d27fa70f5212362f3c924dd0ef6f0f4c1f0f5965c4f8c429977c314bebb7b0715b3ba39b070cdd2ecd05175041545807cd158385f1f23454bc12b6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c649b3d65501daa7a08a88795eaf4db244c71013bf7a45dd1b8f308ac71358f6cc263858b5b284af7e62ace5b5ef360f32fb46b375db62cb2d11dc4618aedae0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/56d10a8cc991a0ad89df4e6820caa7cf68c6a4c550b56c55f5083238e40d55a3878e89040ddaafc9541333d525a25d1d0cedcc0f1638248e969866e639938131"} 09:59:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:59:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:59:19 INFO - Contents: 09:59:19 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fc3a837538d27fa70f5212362f3c924dd0ef6f0f4c1f0f5965c4f8c429977c314bebb7b0715b3ba39b070cdd2ecd05175041545807cd158385f1f23454bc12b6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c649b3d65501daa7a08a88795eaf4db244c71013bf7a45dd1b8f308ac71358f6cc263858b5b284af7e62ace5b5ef360f32fb46b375db62cb2d11dc4618aedae0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/56d10a8cc991a0ad89df4e6820caa7cf68c6a4c550b56c55f5083238e40d55a3878e89040ddaafc9541333d525a25d1d0cedcc0f1638248e969866e639938131"} 09:59:19 INFO - Running post-run listener: copy_logs_to_upload_dir 09:59:19 INFO - Copying logs to upload dir... 09:59:19 INFO - mkdir: /builds/slave/test/build/upload/logs 09:59:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.394144 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-11-24 09:59:20.011581) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-24 09:59:20.014899) ========= 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.PcMXCQDMuH/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.oNMDdPKran/Listeners TMPDIR=/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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-Beta/sha512/fc3a837538d27fa70f5212362f3c924dd0ef6f0f4c1f0f5965c4f8c429977c314bebb7b0715b3ba39b070cdd2ecd05175041545807cd158385f1f23454bc12b6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c649b3d65501daa7a08a88795eaf4db244c71013bf7a45dd1b8f308ac71358f6cc263858b5b284af7e62ace5b5ef360f32fb46b375db62cb2d11dc4618aedae0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/56d10a8cc991a0ad89df4e6820caa7cf68c6a4c550b56c55f5083238e40d55a3878e89040ddaafc9541333d525a25d1d0cedcc0f1638248e969866e639938131"} build_url:https://queue.taskcluster.net/v1/task/aezE_4YzTjqyouoa2mfF0g/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010564 build_url: 'https://queue.taskcluster.net/v1/task/aezE_4YzTjqyouoa2mfF0g/artifacts/public/build/firefox-51.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fc3a837538d27fa70f5212362f3c924dd0ef6f0f4c1f0f5965c4f8c429977c314bebb7b0715b3ba39b070cdd2ecd05175041545807cd158385f1f23454bc12b6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c649b3d65501daa7a08a88795eaf4db244c71013bf7a45dd1b8f308ac71358f6cc263858b5b284af7e62ace5b5ef360f32fb46b375db62cb2d11dc4618aedae0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/56d10a8cc991a0ad89df4e6820caa7cf68c6a4c550b56c55f5083238e40d55a3878e89040ddaafc9541333d525a25d1d0cedcc0f1638248e969866e639938131"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-24 09:59:20.049118) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 09:59:20.049536) ========= 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.PcMXCQDMuH/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.oNMDdPKran/Listeners TMPDIR=/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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.005251 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 09:59:20.100256) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-24 09:59:20.100635) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-24 09:59:20.101449) ========= ========= Total master_lag: 0.71 =========