builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0132 starttime: 1484002046.52 results: success (0) buildid: 20170109122708 builduid: 486aa4469f6948de849da3cdd84f6cc3 revision: 15bc266327e4345d5e830520f5e055c39aac3996 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-09 14:47:26.516997) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-09 14:47:26.517424) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-09 14:47:26.517713) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-09 14:47:26.544160) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 14:47:26.544556) ========= 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.HI4IAtojgd/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.WtoISBGXPa/Listeners TMPDIR=/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-09 14:47:26-- 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% 14.8M=0.001s 2017-01-09 14:47:26 (14.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.126778 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 14:47:26.695430) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 14:47:26.698788) ========= 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.HI4IAtojgd/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.WtoISBGXPa/Listeners TMPDIR=/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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.028037 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 14:47:26.748865) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-09 14:47:26.749230) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 15bc266327e4345d5e830520f5e055c39aac3996 --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 15bc266327e4345d5e830520f5e055c39aac3996 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.HI4IAtojgd/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.WtoISBGXPa/Listeners TMPDIR=/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-09 14:47:26,845 truncating revision to first 12 chars 2017-01-09 14:47:26,845 Setting DEBUG logging. 2017-01-09 14:47:26,845 attempt 1/10 2017-01-09 14:47:26,845 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/15bc266327e4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-09 14:47:27,919 unpacking tar archive at: mozilla-beta-15bc266327e4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.354330 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-09 14:47:28.130008) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-09 14:47:28.130360) ========= script_repo_revision: 15bc266327e4345d5e830520f5e055c39aac3996 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-09 14:47:28.133827) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-09 14:47:28.134095) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-09 14:47:28.154290) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-01-09 14:47:28.154686) ========= /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.HI4IAtojgd/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.WtoISBGXPa/Listeners TMPDIR=/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 14:47:28 INFO - MultiFileLogger online at 20170109 14:47:28 in /builds/slave/test 14:47:28 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 14:47:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:47:28 INFO - {'append_to_log': False, 14:47:28 INFO - 'base_work_dir': '/builds/slave/test', 14:47:28 INFO - 'blob_upload_branch': 'Mozilla-Beta', 14:47:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:47:28 INFO - 'branch': 'Mozilla-Beta', 14:47:28 INFO - 'buildbot_json_path': 'buildprops.json', 14:47:28 INFO - 'config_files': ('talos/mac_config.py',), 14:47:28 INFO - 'default_actions': ('clobber', 14:47:28 INFO - 'read-buildbot-config', 14:47:28 INFO - 'download-and-extract', 14:47:28 INFO - 'populate-webroot', 14:47:28 INFO - 'create-virtualenv', 14:47:28 INFO - 'install', 14:47:28 INFO - 'run-tests'), 14:47:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:47:28 INFO - 'download_minidump_stackwalk': True, 14:47:28 INFO - 'download_symbols': 'ondemand', 14:47:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:47:28 INFO - 'tooltool.py': '/tools/tooltool.py', 14:47:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:47:28 INFO - '/tools/misc-python/virtualenv.py')}, 14:47:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:47:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:47:28 INFO - 'installer_path': 'installer.exe', 14:47:28 INFO - 'log_level': 'info', 14:47:28 INFO - 'log_name': 'talos', 14:47:28 INFO - 'log_to_console': True, 14:47:28 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:47:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:47:28 INFO - 'opt_config_files': (), 14:47:28 INFO - 'pip_index': False, 14:47:28 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:47:28 INFO - 'cmd': ('bash', 14:47:28 INFO - '-c', 14:47:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:47:28 INFO - 'enabled': True, 14:47:28 INFO - 'halt_on_failure': False, 14:47:28 INFO - 'name': 'check_screen_resolution'},), 14:47:28 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:47:28 INFO - 'cmd': ('bash', 14:47:28 INFO - '-c', 14:47:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:47:28 INFO - 'enabled': True, 14:47:28 INFO - 'halt_on_failure': False, 14:47:28 INFO - 'name': 'check_screen_resolution'},), 14:47:28 INFO - 'run_cmd_checks_enabled': True, 14:47:28 INFO - 'sps_profile': False, 14:47:28 INFO - 'sps_profile_interval': 0, 14:47:28 INFO - 'suite': 'dromaeojs-e10s', 14:47:28 INFO - 'system_bits': '32', 14:47:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:47:28 INFO - 'title': 't-yosemite-r7-0132', 14:47:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:47:28 INFO - 'use_talos_json': True, 14:47:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:47:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:47:28 INFO - 'work_dir': 'build'} 14:47:28 INFO - [mozharness: 2017-01-09 22:47:28.351850Z] Running clobber step. 14:47:28 INFO - Running pre-action listener: _resource_record_pre_action 14:47:28 INFO - Running main action method: clobber 14:47:28 INFO - rmtree: /builds/slave/test/build 14:47:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:47:30 INFO - Running post-action listener: _resource_record_post_action 14:47:30 INFO - [mozharness: 2017-01-09 22:47:30.582008Z] Finished clobber step (success) 14:47:30 INFO - [mozharness: 2017-01-09 22:47:30.582129Z] Running read-buildbot-config step. 14:47:30 INFO - Running pre-action listener: _resource_record_pre_action 14:47:30 INFO - Running main action method: read_buildbot_config 14:47:30 INFO - Using buildbot properties: 14:47:30 INFO - { 14:47:30 INFO - "project": "", 14:47:30 INFO - "product": "firefox", 14:47:30 INFO - "script_repo_revision": "production", 14:47:30 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 14:47:30 INFO - "repository": "", 14:47:30 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 14:47:30 INFO - "buildid": "20170109122708", 14:47:30 INFO - "pgo_build": "False", 14:47:30 INFO - "basedir": "/builds/slave/test", 14:47:30 INFO - "buildnumber": 26, 14:47:30 INFO - "slavename": "t-yosemite-r7-0132", 14:47:30 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 14:47:30 INFO - "platform": "yosemite_r7", 14:47:30 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 14:47:30 INFO - "branch": "mozilla-beta", 14:47:30 INFO - "repo_path": "releases/mozilla-beta", 14:47:30 INFO - "revision": "15bc266327e4345d5e830520f5e055c39aac3996", 14:47:30 INFO - "stage_platform": "macosx64", 14:47:30 INFO - "builduid": "486aa4469f6948de849da3cdd84f6cc3", 14:47:30 INFO - "slavebuilddir": "test" 14:47:30 INFO - } 14:47:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/OT6Np3fyRkSkOrV8JvuH8g/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 14:47:30 INFO - Running post-action listener: _resource_record_post_action 14:47:30 INFO - [mozharness: 2017-01-09 22:47:30.585427Z] Finished read-buildbot-config step (success) 14:47:30 INFO - [mozharness: 2017-01-09 22:47:30.585519Z] Running download-and-extract step. 14:47:30 INFO - Running pre-action listener: _resource_record_pre_action 14:47:30 INFO - Running main action method: download_and_extract 14:47:30 INFO - mkdir: /builds/slave/test/build/tests 14:47:30 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')]} 14:47:30 INFO - trying https://queue.taskcluster.net/v1/task/OT6Np3fyRkSkOrV8JvuH8g/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 14:47:30 INFO - Downloading https://queue.taskcluster.net/v1/task/OT6Np3fyRkSkOrV8JvuH8g/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 14:47:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OT6Np3fyRkSkOrV8JvuH8g/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 14:47:31 INFO - Downloaded 1165 bytes. 14:47:31 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 14:47:31 INFO - Using the following test package requirements: 14:47:31 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 14:47:31 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 14:47:31 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 14:47:31 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 14:47:31 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 14:47:31 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 14:47:31 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 14:47:31 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 14:47:31 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 14:47:31 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 14:47:31 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 14:47:31 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 14:47:31 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 14:47:31 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 14:47:31 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 14:47:31 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 14:47:31 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 14:47:31 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 14:47:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OT6Np3fyRkSkOrV8JvuH8g/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 14:47:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OT6Np3fyRkSkOrV8JvuH8g/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 14:47:31 INFO - Fetch https://queue.taskcluster.net/v1/task/OT6Np3fyRkSkOrV8JvuH8g/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 14:47:32 INFO - Expected file size: 16234550 14:47:38 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 14:47:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OT6Np3fyRkSkOrV8JvuH8g/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 14:47:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OT6Np3fyRkSkOrV8JvuH8g/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 14:47:38 INFO - Fetch https://queue.taskcluster.net/v1/task/OT6Np3fyRkSkOrV8JvuH8g/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 14:47:39 INFO - Expected file size: 16234550 14:47:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OT6Np3fyRkSkOrV8JvuH8g/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 14:47:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OT6Np3fyRkSkOrV8JvuH8g/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 14:47:45 INFO - Fetch https://queue.taskcluster.net/v1/task/OT6Np3fyRkSkOrV8JvuH8g/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 14:47:47 INFO - Expected file size: 14414089 14:47:47 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')]} 14:47:47 INFO - trying https://queue.taskcluster.net/v1/task/OT6Np3fyRkSkOrV8JvuH8g/artifacts/public/build/firefox-51.0.en-US.mac.dmg 14:47:47 INFO - Downloading https://queue.taskcluster.net/v1/task/OT6Np3fyRkSkOrV8JvuH8g/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 14:47:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OT6Np3fyRkSkOrV8JvuH8g/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 14:47:50 INFO - Downloaded 86145717 bytes. 14:47:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OT6Np3fyRkSkOrV8JvuH8g/artifacts/public/build/firefox-51.0.en-US.mac.dmg 14:47:50 INFO - mkdir: /builds/slave/test/properties 14:47:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:47:50 INFO - Writing to file /builds/slave/test/properties/build_url 14:47:50 INFO - Contents: 14:47:50 INFO - build_url:https://queue.taskcluster.net/v1/task/OT6Np3fyRkSkOrV8JvuH8g/artifacts/public/build/firefox-51.0.en-US.mac.dmg 14:47:50 INFO - Running post-action listener: _resource_record_post_action 14:47:50 INFO - Running post-action listener: set_extra_try_arguments 14:47:50 INFO - [mozharness: 2017-01-09 22:47:50.931873Z] Finished download-and-extract step (success) 14:47:50 INFO - [mozharness: 2017-01-09 22:47:50.932041Z] Running populate-webroot step. 14:47:50 INFO - Running pre-action listener: _resource_record_pre_action 14:47:50 INFO - Running main action method: populate_webroot 14:47:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:47:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:47:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:47:50 INFO - '--tppagecycles', 14:47:50 INFO - '7'], 14:47:50 INFO - 'tests': ['tsvgm']}}, 14:47:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:47:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:47:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:47:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:47:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:47:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:47:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:47:50 INFO - 'talos_options': ['--disable-e10s'], 14:47:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:47:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:47:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:47:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:47:50 INFO - 'talos_options': ['--disable-e10s'], 14:47:50 INFO - 'tests': ['damp', 'tps']}, 14:47:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:47:50 INFO - 'tests': ['damp', 'tps']}, 14:47:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:47:50 INFO - 'tests': ['dromaeo_dom']}, 14:47:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:47:50 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:47:50 INFO - 'tests': ['basic_compositor_video']}, 14:47:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:47:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:47:50 INFO - 'tests': ['a11yr', 14:47:50 INFO - 'ts_paint', 14:47:50 INFO - 'tpaint', 14:47:50 INFO - 'sessionrestore', 14:47:50 INFO - 'sessionrestore_no_auto_restore', 14:47:50 INFO - 'tabpaint']}, 14:47:50 INFO - 'other-e10s': {'tests': ['a11yr', 14:47:50 INFO - 'ts_paint', 14:47:50 INFO - 'tpaint', 14:47:50 INFO - 'sessionrestore', 14:47:50 INFO - 'sessionrestore_no_auto_restore', 14:47:50 INFO - 'tabpaint']}, 14:47:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:47:50 INFO - 'ts_paint', 14:47:50 INFO - 'tpaint', 14:47:50 INFO - 'sessionrestore', 14:47:50 INFO - 'sessionrestore_no_auto_restore', 14:47:50 INFO - 'tabpaint']}, 14:47:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:47:50 INFO - 'ts_paint', 14:47:50 INFO - 'tpaint', 14:47:50 INFO - 'sessionrestore', 14:47:50 INFO - 'sessionrestore_no_auto_restore', 14:47:50 INFO - 'tabpaint']}, 14:47:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:47:50 INFO - 'tests': ['a11yr', 14:47:50 INFO - 'ts_paint', 14:47:50 INFO - 'tpaint', 14:47:50 INFO - 'sessionrestore', 14:47:50 INFO - 'sessionrestore_no_auto_restore', 14:47:50 INFO - 'tabpaint']}, 14:47:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:47:50 INFO - 'tests': ['a11yr', 14:47:50 INFO - 'ts_paint', 14:47:50 INFO - 'tpaint', 14:47:50 INFO - 'sessionrestore', 14:47:50 INFO - 'sessionrestore_no_auto_restore', 14:47:50 INFO - 'tabpaint']}, 14:47:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:47:50 INFO - 'tests': ['tsvgx', 14:47:50 INFO - 'tsvgr_opacity', 14:47:50 INFO - 'tart', 14:47:50 INFO - 'tscrollx', 14:47:50 INFO - 'cart']}, 14:47:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:47:50 INFO - 'tsvgr_opacity', 14:47:50 INFO - 'tart', 14:47:50 INFO - 'tscrollx', 14:47:50 INFO - 'cart']}, 14:47:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:47:50 INFO - 'talos_options': ['--disable-e10s'], 14:47:50 INFO - 'tests': ['tp5o']}, 14:47:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:47:50 INFO - 'tests': ['tp5o']}, 14:47:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:47:50 INFO - 'talos_options': ['--disable-e10s', 14:47:50 INFO - '--xperf_path', 14:47:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:47:50 INFO - 'tests': ['tp5n']}, 14:47:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:47:50 INFO - 'talos_options': ['--xperf_path', 14:47:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:47:50 INFO - 'tests': ['tp5n']}}, 14:47:50 INFO - 'talos.zip': {'path': '', 14:47:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:47:50 INFO - Running post-action listener: _resource_record_post_action 14:47:50 INFO - [mozharness: 2017-01-09 22:47:50.950402Z] Finished populate-webroot step (success) 14:47:50 INFO - [mozharness: 2017-01-09 22:47:50.950499Z] Running create-virtualenv step. 14:47:50 INFO - Running pre-action listener: _resource_record_pre_action 14:47:50 INFO - Running main action method: create_virtualenv 14:47:50 INFO - Creating virtualenv /builds/slave/test/build/venv 14:47:50 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:47:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:47:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:47:51 INFO - Using real prefix '/tools/python27' 14:47:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:47:51 INFO - Installing distribute.............................................................................................................................................................................................done. 14:47:54 INFO - Installing pip.................done. 14:47:54 INFO - Return code: 0 14:47:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:47:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:47:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:47:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:47:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:47:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e1be490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e134570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc71479930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfd2d30>, '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 0x10de38db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfcab20>, '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.HI4IAtojgd/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.WtoISBGXPa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 14:47:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:47:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:47:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HI4IAtojgd/Render', 14:47:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:47:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:47:54 INFO - 'HOME': '/Users/cltbld', 14:47:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:47:54 INFO - 'LOGNAME': 'cltbld', 14:47:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:47:54 INFO - 'MOZ_NO_REMOTE': '1', 14:47:54 INFO - 'NO_EM_RESTART': '1', 14:47:54 INFO - 'PAGER': '/bin/cat', 14:47:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:47:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:47:54 INFO - 'PWD': '/builds/slave/test', 14:47:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:47:54 INFO - 'SHELL': '/bin/bash', 14:47:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WtoISBGXPa/Listeners', 14:47:54 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 14:47:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:47:54 INFO - 'USER': 'cltbld', 14:47:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:47:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:47:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:47:54 INFO - 'XPC_FLAGS': '0x0', 14:47:54 INFO - 'XPC_SERVICE_NAME': '0', 14:47:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:47:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:47:54 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:47:54 INFO - Cleaning up... 14:47:54 INFO - Return code: 0 14:47:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:47:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:47:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:47:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:47:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:47:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e1be490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e134570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc71479930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfd2d30>, '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 0x10de38db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfcab20>, '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.HI4IAtojgd/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.WtoISBGXPa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 14:47:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:47:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:47:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HI4IAtojgd/Render', 14:47:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:47:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:47:54 INFO - 'HOME': '/Users/cltbld', 14:47:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:47:54 INFO - 'LOGNAME': 'cltbld', 14:47:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:47:54 INFO - 'MOZ_NO_REMOTE': '1', 14:47:54 INFO - 'NO_EM_RESTART': '1', 14:47:54 INFO - 'PAGER': '/bin/cat', 14:47:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:47:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:47:54 INFO - 'PWD': '/builds/slave/test', 14:47:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:47:54 INFO - 'SHELL': '/bin/bash', 14:47:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WtoISBGXPa/Listeners', 14:47:54 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 14:47:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:47:54 INFO - 'USER': 'cltbld', 14:47:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:47:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:47:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:47:54 INFO - 'XPC_FLAGS': '0x0', 14:47:54 INFO - 'XPC_SERVICE_NAME': '0', 14:47:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:47:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:47:55 INFO - Downloading/unpacking psutil>=3.1.1 14:47:55 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 14:47:55 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 14:47:55 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 14:47:55 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 14:47:55 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 14:47:55 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 14:47:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:47:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:47:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:47:58 INFO - Installing collected packages: psutil 14:47:58 INFO - Running setup.py install for psutil 14:47:58 INFO - building 'psutil._psutil_osx' extension 14:47:58 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 14:47:59 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 14:47:59 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 14:47:59 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 14:47:59 INFO - building 'psutil._psutil_posix' extension 14:47:59 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 14:47:59 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:47:59 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:47:59 INFO - ^ 14:47:59 INFO - 1 warning generated. 14:47:59 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 14:47:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:47:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:47:59 INFO - Successfully installed psutil 14:47:59 INFO - Cleaning up... 14:47:59 INFO - Return code: 0 14:47:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:47: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')]} 14:47:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:47:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47: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')]} 14:47:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:47:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:47:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e1be490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e134570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc71479930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfd2d30>, '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 0x10de38db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfcab20>, '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.HI4IAtojgd/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.WtoISBGXPa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 14:47:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:47:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:47:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HI4IAtojgd/Render', 14:47:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:47:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:47:59 INFO - 'HOME': '/Users/cltbld', 14:47:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:47:59 INFO - 'LOGNAME': 'cltbld', 14:47:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:47:59 INFO - 'MOZ_NO_REMOTE': '1', 14:47:59 INFO - 'NO_EM_RESTART': '1', 14:47:59 INFO - 'PAGER': '/bin/cat', 14:47:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:47:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:47:59 INFO - 'PWD': '/builds/slave/test', 14:47:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:47:59 INFO - 'SHELL': '/bin/bash', 14:47:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WtoISBGXPa/Listeners', 14:47:59 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 14:47:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:47:59 INFO - 'USER': 'cltbld', 14:47:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:47:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:47:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:47:59 INFO - 'XPC_FLAGS': '0x0', 14:47:59 INFO - 'XPC_SERVICE_NAME': '0', 14:47:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:48:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:48:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:48:00 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 14:48:00 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 14:48:00 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 14:48:00 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 14:48:00 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 14:48:00 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 14:48:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:48:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:48:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:48:02 INFO - Installing collected packages: mozsystemmonitor 14:48:02 INFO - Running setup.py install for mozsystemmonitor 14:48:02 INFO - Successfully installed mozsystemmonitor 14:48:02 INFO - Cleaning up... 14:48:03 INFO - Return code: 0 14:48:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:48: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')]} 14:48:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48: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')]} 14:48:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48: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', '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 0x10e1be490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e134570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc71479930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfd2d30>, '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 0x10de38db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfcab20>, '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.HI4IAtojgd/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.WtoISBGXPa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 14:48: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:48: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 jsonschema==2.5.1 14:48:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HI4IAtojgd/Render', 14:48:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:48:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:48:03 INFO - 'HOME': '/Users/cltbld', 14:48:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:48:03 INFO - 'LOGNAME': 'cltbld', 14:48:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:03 INFO - 'MOZ_NO_REMOTE': '1', 14:48:03 INFO - 'NO_EM_RESTART': '1', 14:48:03 INFO - 'PAGER': '/bin/cat', 14:48:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:48:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:03 INFO - 'PWD': '/builds/slave/test', 14:48:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:48:03 INFO - 'SHELL': '/bin/bash', 14:48:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WtoISBGXPa/Listeners', 14:48:03 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 14:48:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:48:03 INFO - 'USER': 'cltbld', 14:48:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:48:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:48:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:03 INFO - 'XPC_FLAGS': '0x0', 14:48:03 INFO - 'XPC_SERVICE_NAME': '0', 14:48:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:48:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:48:03 INFO - Downloading/unpacking jsonschema==2.5.1 14:48:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:48:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:48:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:48:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:48:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:48:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:48:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:48:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:48: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 14:48: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 14:48: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 14:48: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 14:48: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 14:48: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 14:48:06 INFO - Downloading functools32-3.2.3-2.tar.gz 14:48:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:48:06 INFO - warning: no files found matching '*.txt' 14:48:06 INFO - no previously-included directories found matching 'build' 14:48:06 INFO - no previously-included directories found matching 'dist' 14:48:06 INFO - no previously-included directories found matching '.git*' 14:48:06 INFO - Installing collected packages: jsonschema, functools32 14:48:06 INFO - Running setup.py install for functools32 14:48:06 INFO - warning: no files found matching '*.txt' 14:48:06 INFO - no previously-included directories found matching 'build' 14:48:06 INFO - no previously-included directories found matching 'dist' 14:48:06 INFO - no previously-included directories found matching '.git*' 14:48:06 INFO - Successfully installed jsonschema functools32 14:48:06 INFO - Cleaning up... 14:48:06 INFO - Return code: 0 14:48:06 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:48:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:48:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:48:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e1be490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e134570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc71479930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfd2d30>, '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 0x10de38db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfcab20>, '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.HI4IAtojgd/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.WtoISBGXPa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 14:48:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:48:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 14:48:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HI4IAtojgd/Render', 14:48:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:48:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:48:06 INFO - 'HOME': '/Users/cltbld', 14:48:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:48:06 INFO - 'LOGNAME': 'cltbld', 14:48:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:06 INFO - 'MOZ_NO_REMOTE': '1', 14:48:06 INFO - 'NO_EM_RESTART': '1', 14:48:06 INFO - 'PAGER': '/bin/cat', 14:48:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:48:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:06 INFO - 'PWD': '/builds/slave/test', 14:48:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:48:06 INFO - 'SHELL': '/bin/bash', 14:48:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WtoISBGXPa/Listeners', 14:48:06 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 14:48:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:48:06 INFO - 'USER': 'cltbld', 14:48:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:48:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:48:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:06 INFO - 'XPC_FLAGS': '0x0', 14:48:06 INFO - 'XPC_SERVICE_NAME': '0', 14:48:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:48:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:48:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:48:06 INFO - Cleaning up... 14:48:06 INFO - Return code: 0 14:48:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:48:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:07 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')]} 14:48:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:07 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 0x10e1be490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e134570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc71479930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfd2d30>, '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 0x10de38db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfcab20>, '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.HI4IAtojgd/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.WtoISBGXPa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 14:48:07 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 14:48:07 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 14:48:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HI4IAtojgd/Render', 14:48:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:48:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:48:07 INFO - 'HOME': '/Users/cltbld', 14:48:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:48:07 INFO - 'LOGNAME': 'cltbld', 14:48:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:07 INFO - 'MOZ_NO_REMOTE': '1', 14:48:07 INFO - 'NO_EM_RESTART': '1', 14:48:07 INFO - 'PAGER': '/bin/cat', 14:48:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:48:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:07 INFO - 'PWD': '/builds/slave/test', 14:48:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:48:07 INFO - 'SHELL': '/bin/bash', 14:48:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WtoISBGXPa/Listeners', 14:48:07 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 14:48:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:48:07 INFO - 'USER': 'cltbld', 14:48:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:48:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:48:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:07 INFO - 'XPC_FLAGS': '0x0', 14:48:07 INFO - 'XPC_SERVICE_NAME': '0', 14:48:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:48:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:48:07 INFO - Downloading/unpacking blobuploader==1.2.4 14:48:07 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 14:48:07 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 14:48:07 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 14:48:07 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 14:48:07 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 14:48:07 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 14:48:09 INFO - Downloading blobuploader-1.2.4.tar.gz 14:48:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:48:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:48:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:48:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:48:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:48:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:48:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:48:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:48:10 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 14:48:10 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 14:48:10 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 14:48:10 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 14:48:10 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 14:48:10 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 14:48:11 INFO - Downloading docopt-0.6.1.tar.gz 14:48:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:48:11 INFO - Installing collected packages: blobuploader, requests, docopt 14:48:11 INFO - Running setup.py install for blobuploader 14:48:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:48:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:48:11 INFO - Running setup.py install for requests 14:48:11 INFO - Running setup.py install for docopt 14:48:12 INFO - Successfully installed blobuploader requests docopt 14:48:12 INFO - Cleaning up... 14:48:12 INFO - Return code: 0 14:48:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:48: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')]} 14:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48: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')]} 14:48:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:12 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 0x10e1be490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e134570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc71479930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfd2d30>, '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 0x10de38db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfcab20>, '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.HI4IAtojgd/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.WtoISBGXPa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 14:48:12 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 14:48:12 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 14:48:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HI4IAtojgd/Render', 14:48:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:48:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:48:12 INFO - 'HOME': '/Users/cltbld', 14:48:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:48:12 INFO - 'LOGNAME': 'cltbld', 14:48:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:12 INFO - 'MOZ_NO_REMOTE': '1', 14:48:12 INFO - 'NO_EM_RESTART': '1', 14:48:12 INFO - 'PAGER': '/bin/cat', 14:48:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:48:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:12 INFO - 'PWD': '/builds/slave/test', 14:48:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:48:12 INFO - 'SHELL': '/bin/bash', 14:48:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WtoISBGXPa/Listeners', 14:48:12 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 14:48:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:48:12 INFO - 'USER': 'cltbld', 14:48:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:48:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:48:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:12 INFO - 'XPC_FLAGS': '0x0', 14:48:12 INFO - 'XPC_SERVICE_NAME': '0', 14:48:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:48:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:48:12 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-Ob0bGB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:48:12 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-q4bam3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:48:12 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-_6dAzD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:48:12 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-1JF6aB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:48:12 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-0ysBVQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:48:12 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-zOVRap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:48:13 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-eqRr_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:48:13 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-aCnIzp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:48:13 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-OD0GN0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:48:13 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-B4O9Cl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:48:13 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-vF4uUk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:48:13 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-q9pOZ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:48:13 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-Nam_c6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:48:13 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-9Qy4Zt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:48:13 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-sLcRRG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:48:13 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-zapLek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:48:14 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-ruD7jI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:48:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:48:14 INFO - Running setup.py install for manifestparser 14:48:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:48:14 INFO - Running setup.py install for mozcrash 14:48:14 INFO - Running setup.py install for mozdebug 14:48:14 INFO - Running setup.py install for mozdevice 14:48:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:48:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:48:14 INFO - Running setup.py install for mozfile 14:48:14 INFO - Running setup.py install for mozhttpd 14:48:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:48:15 INFO - Running setup.py install for mozinfo 14:48:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:48:15 INFO - Running setup.py install for mozInstall 14:48:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:48:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:48:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:48:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:48:15 INFO - Running setup.py install for mozleak 14:48:15 INFO - Running setup.py install for mozlog 14:48:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:48:15 INFO - Running setup.py install for moznetwork 14:48:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:48:15 INFO - Running setup.py install for mozprocess 14:48:15 INFO - Running setup.py install for mozprofile 14:48:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:48:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:48:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:48:16 INFO - Running setup.py install for mozrunner 14:48:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:48:16 INFO - Running setup.py install for mozscreenshot 14:48:16 INFO - Running setup.py install for moztest 14:48:16 INFO - Running setup.py install for mozversion 14:48:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:48:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:48:16 INFO - Cleaning up... 14:48:16 INFO - Return code: 0 14:48:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:48:16 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')]} 14:48:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:16 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')]} 14:48:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:16 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 0x10e1be490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e134570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc71479930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfd2d30>, '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 0x10de38db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfcab20>, '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.HI4IAtojgd/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.WtoISBGXPa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 14:48:16 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 14:48:16 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 14:48:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HI4IAtojgd/Render', 14:48:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:48:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:48:16 INFO - 'HOME': '/Users/cltbld', 14:48:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:48:16 INFO - 'LOGNAME': 'cltbld', 14:48:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:16 INFO - 'MOZ_NO_REMOTE': '1', 14:48:16 INFO - 'NO_EM_RESTART': '1', 14:48:16 INFO - 'PAGER': '/bin/cat', 14:48:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:48:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:16 INFO - 'PWD': '/builds/slave/test', 14:48:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:48:16 INFO - 'SHELL': '/bin/bash', 14:48:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WtoISBGXPa/Listeners', 14:48:16 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 14:48:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:48:16 INFO - 'USER': 'cltbld', 14:48:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:48:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:48:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:16 INFO - 'XPC_FLAGS': '0x0', 14:48:16 INFO - 'XPC_SERVICE_NAME': '0', 14:48:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:48:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:48:17 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-Zwjo4q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:48:17 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)) 14:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:48:17 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-BX2BdV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:48:17 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)) 14:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:48:17 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-lfW7lr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:48:17 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)) 14:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:48:17 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-GBstTp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:48:17 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)) 14:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:48:17 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-MlsU_q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:48:17 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)) 14:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:48:17 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-6CXTQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:48:17 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)) 14:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:48:17 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-t8mdlv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:48:17 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)) 14:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:48:17 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-jfhHou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:48:17 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)) 14:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:48:17 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-AFEKWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:48:17 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)) 14:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:48:17 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-cA_03j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:48:18 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)) 14:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:48:18 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-bVGaRj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:48:18 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)) 14:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:48:18 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-toAD4c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:48:18 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)) 14:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:48:18 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-woXBB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:48:18 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)) 14:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:48:18 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-797HAx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:48:18 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)) 14:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:48:18 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-DHBe6Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:48:18 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)) 14:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:48:18 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-dUxCeb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:48:18 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)) 14:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:48:18 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-f5GWdy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:48:18 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)) 14:48:18 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)) 14:48:18 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)) 14:48:18 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)) 14:48:18 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)) 14:48:18 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)) 14:48:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:48:18 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 14:48:18 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 14:48:18 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 14:48:18 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 14:48:18 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 14:48:18 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 14:48:21 INFO - Downloading blessings-1.6.tar.gz 14:48:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:48:22 INFO - Installing collected packages: blessings 14:48:22 INFO - Running setup.py install for blessings 14:48:22 INFO - Successfully installed blessings 14:48:22 INFO - Cleaning up... 14:48:22 INFO - Return code: 0 14:48:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:48:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:48:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:48:22 INFO - Reading from file tmpfile_stdout 14:48:22 INFO - Current package versions: 14:48:22 INFO - blessings == 1.6 14:48:22 INFO - blobuploader == 1.2.4 14:48:22 INFO - docopt == 0.6.1 14:48:22 INFO - functools32 == 3.2.3-2 14:48:22 INFO - jsonschema == 2.5.1 14:48:22 INFO - manifestparser == 1.1 14:48:22 INFO - mozInstall == 1.12 14:48:22 INFO - mozcrash == 0.17 14:48:22 INFO - mozdebug == 0.1 14:48:22 INFO - mozdevice == 0.48 14:48:22 INFO - mozfile == 1.2 14:48:22 INFO - mozhttpd == 0.7 14:48:22 INFO - mozinfo == 0.9 14:48:22 INFO - mozleak == 0.1 14:48:22 INFO - mozlog == 3.4 14:48:22 INFO - moznetwork == 0.27 14:48:22 INFO - mozprocess == 0.23 14:48:22 INFO - mozprofile == 0.28 14:48:22 INFO - mozrunner == 6.12 14:48:22 INFO - mozscreenshot == 0.1 14:48:22 INFO - mozsystemmonitor == 0.3 14:48:22 INFO - moztest == 0.7 14:48:22 INFO - mozversion == 1.4 14:48:22 INFO - psutil == 3.1.1 14:48:22 INFO - requests == 1.2.3 14:48:22 INFO - wsgiref == 0.1.2 14:48:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:48:22 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')]} 14:48:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:22 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')]} 14:48:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:22 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 0x10e1be490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e134570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc71479930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfd2d30>, '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 0x10de38db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfcab20>, '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.HI4IAtojgd/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.WtoISBGXPa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 14:48:22 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 14:48:22 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 14:48:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HI4IAtojgd/Render', 14:48:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:48:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:48:22 INFO - 'HOME': '/Users/cltbld', 14:48:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:48:22 INFO - 'LOGNAME': 'cltbld', 14:48:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:22 INFO - 'MOZ_NO_REMOTE': '1', 14:48:22 INFO - 'NO_EM_RESTART': '1', 14:48:22 INFO - 'PAGER': '/bin/cat', 14:48:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:48:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:22 INFO - 'PWD': '/builds/slave/test', 14:48:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:48:22 INFO - 'SHELL': '/bin/bash', 14:48:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WtoISBGXPa/Listeners', 14:48:22 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 14:48:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:48:22 INFO - 'USER': 'cltbld', 14:48:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:48:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:48:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:22 INFO - 'XPC_FLAGS': '0x0', 14:48:22 INFO - 'XPC_SERVICE_NAME': '0', 14:48:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:48:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:48:23 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)) 14:48:23 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)) 14:48:23 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)) 14:48:23 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)) 14:48:23 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)) 14:48:23 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)) 14:48:23 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)) 14:48:23 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)) 14:48:23 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)) 14:48:23 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)) 14:48:23 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)) 14:48:23 INFO - Cleaning up... 14:48:23 INFO - Return code: 0 14:48:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:48:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:48:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:48:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:48:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:48:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:48:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e1be490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e134570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc71479930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfd2d30>, '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 0x10de38db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfcab20>, '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.HI4IAtojgd/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.WtoISBGXPa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 14:48:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:48:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:48:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HI4IAtojgd/Render', 14:48:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:48:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:48:23 INFO - 'HOME': '/Users/cltbld', 14:48:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:48:23 INFO - 'LOGNAME': 'cltbld', 14:48:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:23 INFO - 'MOZ_NO_REMOTE': '1', 14:48:23 INFO - 'NO_EM_RESTART': '1', 14:48:23 INFO - 'PAGER': '/bin/cat', 14:48:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:48:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:23 INFO - 'PWD': '/builds/slave/test', 14:48:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:48:23 INFO - 'SHELL': '/bin/bash', 14:48:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WtoISBGXPa/Listeners', 14:48:23 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 14:48:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:48:23 INFO - 'USER': 'cltbld', 14:48:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:48:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:48:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:23 INFO - 'XPC_FLAGS': '0x0', 14:48:23 INFO - 'XPC_SERVICE_NAME': '0', 14:48:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:48:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:48:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:48:23 INFO - Cleaning up... 14:48:23 INFO - Return code: 0 14:48:23 INFO - Running post-action listener: _resource_record_post_action 14:48:23 INFO - Running post-action listener: _start_resource_monitoring 14:48:23 INFO - Starting resource monitoring. 14:48:23 INFO - [mozharness: 2017-01-09 22:48:23.518995Z] Finished create-virtualenv step (success) 14:48:23 INFO - [mozharness: 2017-01-09 22:48:23.520022Z] Running install step. 14:48:23 INFO - Running pre-action listener: _resource_record_pre_action 14:48:23 INFO - Running main action method: install 14:48:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:48:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:48:23 INFO - Reading from file tmpfile_stdout 14:48:23 INFO - Detecting whether we're running mozinstall >=1.0... 14:48:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:48:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:48:23 INFO - Reading from file tmpfile_stdout 14:48:23 INFO - Output received: 14:48:23 INFO - Usage: mozinstall [options] installer 14:48:23 INFO - Options: 14:48:23 INFO - -h, --help show this help message and exit 14:48:23 INFO - -d DEST, --destination=DEST 14:48:23 INFO - Directory to install application into. [default: 14:48:23 INFO - "/builds/slave/test"] 14:48:23 INFO - --app=APP Application being installed. [default: firefox] 14:48:23 INFO - mkdir: /builds/slave/test/build/application 14:48:23 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'] 14:48:23 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 14:48:45 INFO - Reading from file tmpfile_stdout 14:48:45 INFO - Output received: 14:48:45 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 14:48:45 INFO - Running post-action listener: _resource_record_post_action 14:48:45 INFO - [mozharness: 2017-01-09 22:48:45.774002Z] Finished install step (success) 14:48:45 INFO - [mozharness: 2017-01-09 22:48:45.774144Z] Running run-tests step. 14:48:45 INFO - Running pre-action listener: _resource_record_pre_action 14:48:45 INFO - Running main action method: run_tests 14:48:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:48:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:48:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:48:45 INFO - 2017-01-09 14:48:45.788 screenresolution[1628:7441] starting screenresolution argv=screenresolution get 14:48:45 INFO - 2017-01-09 14:48:45.791 screenresolution[1628:7441] Display 0: 1600x1200x32@60 14:48:45 INFO - 2017-01-09 14:48:45.796 screenresolution[1629:7443] starting screenresolution argv=screenresolution list 14:48:45 INFO - Available Modes on Display 0 14:48:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:48:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:48:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:48:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:48:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:48:46 INFO - Intel Iris: 14:48:46 INFO - Chipset Model: Intel Iris 14:48:46 INFO - Type: GPU 14:48:46 INFO - Bus: Built-In 14:48:46 INFO - VRAM (Dynamic, Max): 1536 MB 14:48:46 INFO - Vendor: Intel (0x8086) 14:48:46 INFO - Device ID: 0x0a2e 14:48:46 INFO - Revision ID: 0x0009 14:48:46 INFO - Displays: 14:48:46 INFO - Display: 14:48:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:48:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:48:46 INFO - Display Serial Number: 1600x1200 60 14:48:46 INFO - Main Display: Yes 14:48:46 INFO - Mirror: Off 14:48:46 INFO - Online: Yes 14:48:46 INFO - Rotation: Supported 14:48:46 INFO - Return code: 0 14:48:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:48:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:48:46 INFO - Python 2.7.3 14:48:46 INFO - Return code: 0 14:48:46 INFO - grabbing minidump binary from tooltool 14:48:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:48:46 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 0x10dfd2d30>, '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 0x10de38db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfcab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:48:46 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 14:48:46 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 14:48:46 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 14:48:46 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:48:46 INFO - Return code: 0 14:48:46 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:48:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:48:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:48:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:48:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:48:46 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/OT6Np3fyRkSkOrV8JvuH8g/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0132', '--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 14:48:46 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/OT6Np3fyRkSkOrV8JvuH8g/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0132 --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 14:48:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HI4IAtojgd/Render', 14:48:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:48:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:48:46 INFO - 'HOME': '/Users/cltbld', 14:48:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:48:46 INFO - 'LOGNAME': 'cltbld', 14:48:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:48:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:48:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:48:46 INFO - 'MOZ_NO_REMOTE': '1', 14:48:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:48:46 INFO - 'NO_EM_RESTART': '1', 14:48:46 INFO - 'PAGER': '/bin/cat', 14:48:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:48:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:48:46 INFO - 'PWD': '/builds/slave/test', 14:48:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:48:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:48:46 INFO - 'SHELL': '/bin/bash', 14:48:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WtoISBGXPa/Listeners', 14:48:46 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 14:48:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:48:46 INFO - 'USER': 'cltbld', 14:48:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:48:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:48:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:48:46 INFO - 'XPC_FLAGS': '0x0', 14:48:46 INFO - 'XPC_SERVICE_NAME': '0', 14:48:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:48:46 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/OT6Np3fyRkSkOrV8JvuH8g/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0132', '--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 14:48:46 INFO - mozversion application_buildid: 20170109122708 14:48:46 INFO - mozversion application_changeset: 15bc266327e4345d5e830520f5e055c39aac3996 14:48:46 INFO - mozversion application_display_name: Firefox 14:48:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:48:46 INFO - mozversion application_name: Firefox 14:48:46 INFO - mozversion application_remotingname: firefox 14:48:46 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 14:48:46 INFO - mozversion application_vendor: Mozilla 14:48:46 INFO - mozversion application_version: 51.0 14:48:46 INFO - mozversion platform_buildid: 20170109122708 14:48:46 INFO - mozversion platform_changeset: 15bc266327e4345d5e830520f5e055c39aac3996 14:48:46 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 14:48:46 INFO - mozversion platform_version: 51.0 14:48:46 INFO - using testdate: 1484002126 14:48:46 INFO - actual date: 1484002126 14:48:46 INFO - starting webserver on 'localhost:49241' 14:48:46 INFO - SUITE-START | Running 2 tests 14:48:46 INFO - TEST-START | dromaeo_css 14:48:46 INFO - operating with platform_type : mac_ 14:48:46 INFO - Initialising browser for dromaeo_css test... 14:48:46 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/tmpNUotAt/profile http://localhost:49241/getInfo.html) 14:48:48 INFO - PROCESS | 1639 | __metrics Screen width/height:1600/1200 14:48:48 INFO - PROCESS | 1639 | colorDepth:24 14:48:48 INFO - PROCESS | 1639 | Browser inner width/height: 1024/689 14:48:48 INFO - PROCESS | 1639 | __metrics 14:48:49 ERROR - PROCESS | 1639 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3015: TypeError: this.tabs is undefined 14:48:49 INFO - TEST-INFO | 1639: exit 0 14:48:49 INFO - Browser initialized. 14:48:49 INFO - Running cycle 1/1 for dromaeo_css test... 14:48:49 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/tmpNUotAt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:49:01 INFO - PROCESS | 1643 | RSS: Main: 174706688 14:49:01 INFO - PROCESS | 1643 | 14:49:51 INFO - PROCESS | 1643 | 1484002191282 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] 14:52:02 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 14:52:03 INFO - PROCESS | 1643 | RSS: Main: 186408960 14:52:03 INFO - PROCESS | 1643 | 14:55:05 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 14:55:06 INFO - PROCESS | 1643 | RSS: Main: 199151616 14:55:06 INFO - PROCESS | 1643 | 14:58:08 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 14:58:08 INFO - PROCESS | 1643 | RSS: Main: 201785344 14:58:08 INFO - PROCESS | 1643 | 15:01:10 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 15:01:11 INFO - PROCESS | 1643 | RSS: Main: 205074432 15:01:11 INFO - PROCESS | 1643 | 15:04:14 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 15:04:14 INFO - PROCESS | 1643 | RSS: Main: 208093184 15:04:14 INFO - PROCESS | 1643 | 15:07:17 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 15:07:17 INFO - PROCESS | 1643 | RSS: Main: 208609280 15:07:17 INFO - PROCESS | 1643 | 15:07:17 INFO - PROCESS | 1643 | __start_tp_report 15:07:17 INFO - PROCESS | 1643 | _x_x_mozilla_page_load 15:07:17 INFO - PROCESS | 1643 | _x_x_mozilla_page_load_details 15:07:17 INFO - PROCESS | 1643 | |i|pagename|runs| 15:07:17 INFO - PROCESS | 1643 | |0;dojo.html;3590.69479094277;3611.873584424544;3622.529071220741;3628.2380700052995;3667.3582123128444;6051.183090282816;6087;6108.786192483264;6113.327533971265;6128.479079278261;4675.579197872191;6002.639841609506;6042.244719410074;6111.052786818039;6190.288116866562;5385.623006389545;5472.1244600863865;5508.807191748289;5541.778328866841;5587.329520457551;5536.252605898213;5564.304461942257;5567.66594004359;5592.916106258409;5634.12671035988;5398.514133727964;5414.43148469411;5526.696031718254;5552.139418390156;5554.1113421852515;4475.865724028268;5432.429594892538;5498.3127109111365;5537.556995440355;5586.636868603528;5343.572514198855;5471.699056551888;5474.452554744534;5498.642588231752;5527.613067085305;5873.618214816023;6060.909086363708;6099.878002439927;6156.106629883948;6199.597026193283;5283.788648454057;6218.253809542839;6263.874722505524;6272.87454250917;6326.778562750282;6384.297727249998;6385.138006369127;6406.263279722845;6499.2200935887995;6539.738410463576;6173.981293086636;6180.6291622502795;6191.071339299141;6211.565190436717;6219.47134493564;5314.681119132864;5593.580481463825;6439.034144878212;6449.871002579922;6497.122888410098;4719.4100737407825;5336.17289320156;6130.295016073209;6288.371162883675;6314.116023756677;5824.621399609012;6233.376662333821;6296.622202667854;6453.709583068773;6475.158229430144;5577;6232.719527621268;6253.624782513064;6255.499560035186;6360.554761166766;6036.15493830864;6242.812715618538;6275.96862015687;6306.148669929501;6339.049142628643;4433.224185767543;5055.9494405055475;5175.378954525406;5190.532852043334;5206.609504287194;4597.42532183477;4607.470140933769;4637.0262244928945;4673.135469938073;4691.272852707768;6144.293406258337;6158.476529494954;6237.345078766664;6238.282597501346;6248.250209974832;6415.26224484181;6423.2555816392605;6428.871422571522;6447.516436267299;6462.289148193695;6075.939240607626;6108.786192483241;6119.051547010132;6120.081455037911;6146.969265153645;5678.545716342683;5682.40334764852;5694.174344719992;5703.62926409782;5720.08478643415;6648.5346025777735;6668.166479190101;6679.899801502981;6682.665866706645;6706.195256569243;6188.938110619017;6279.246490421178;6289.842753931189;6290.716917738621;6410.038494225903;6626.271110177973;6651.301613330531;6661.300563440769;6661.900071499028;6693.397594216543;6332.936670633235;6347.111404403295;6355.682215889095;6356.237251529661;6362.141110949962;6250.937490625036;6294.055891616111;6318.810435686937;6375.075614036032;6405.519586030973;5283.973580132075;6182.598131121463;6278.7488500461295;6288.905666414916;6312.084747711464;6129.172561704113;6300.495960323255;6308.400701933309;6312.400321969406;6409.647469389042;5978.282606087298;6136.519078024374;6176.258848938156;6213.5339849510565;6246.406591373812;6164.137020816999;6199.380061993765;6240.251169859646;6261.749530018748;6337.271213810471;6222.222222222223;6237.500999919905;6257.812265632038;6270.467010304175;6276.686165691606 15:07:17 INFO - PROCESS | 1643 | |1;ext.html;495.8817865712817;534.1773668550431;540.6107602526182;541.1909195752348;567.2229046206696;41446.58553414465;43479;43488.78255608718;45688.77155614217;45711.54288457114;44556.88607784807;45073.32390014144;45084.87287817806;45167;45230.095398092104;9943.154831839302;10109.292349535535;10115.797684046314;10133.49332533374;10157.898421015807;9879.703608891745;9950.601975920954;10008.349457285289;10011.899881001169;10022.54898529568;9960.850587241197;10005.399676019462;10007.699769006942;10012.499375031255;10027.548760305805;9912.653057143001;9959.15347195482;9986.550605222783;9988.001199880027;10027.04743049409;7796.181400952932;9812.95093524535;9819.90180098197;9894.752631184207;10012.59949602015;35600.465993010126;35785.64214357875;42334.94162645928;42449.36325955113;42740;3302.8018318900704;3418.8461519231696;3470.8958731238104;4165.354370072643;4216.2832318505925;26627.600585991226;31235.531467028013;32295.838520807247;32368.83815580907;32916.50625240623;3348.7153591944716;3360.9354587135376;3400.506926495669;3407.0800883761244;3410.6077801052948;468798;537452;545348;546984;547569;34159.829200854336;61261;61304.241309141195;61579.69210153921;61636.69181654063;34512;36531.904042878756;36928;37012.44481332782;37150.25699485995;15757.606059848595;15957;15962.920185398998;15970.600734981486;16003.359865605245;13305.66735831612;13316.467341306434;13348.065635405623;13408.798868016987;13419.194848309133;7947.245011723877;7970.721024764105;8028.07677117139;8138.226868447488;8138.226868447488;3394.387665858747;3404.472306792451;3430.2967891582166;3432.7597068205487;3443.27691184854;972.6595691508057;979.8187335342842;988.4563490080427;1040.9798397570423;1060.925735198544;31549.36901261962;31642.683573163973;31732.04803855888;31856.203594910312;32053.839730801665;1056.144522936424;1072.453048945028;1112.6383925224172;1130.1749722702473;1138.2430683595483;15567.688646227012;16557.668846623;16567.337306507605;16634.667306654042;16671.6665666686;723451;730682;731189;741172;744101;60801.47996300128;61413.38586614166;61583.692081540205;61590.38409615936;61646;1384.508499482669;1427.1019544006447;1431.5991522373752;1442.2716528153217;1445.7253121907015;30136.698633013388;33584.83207583946;33929.49105763366;33973.49039764455;35211.64788352186;58978.70510647419;59812;59853.40146598478;63803.36196637974;63915;658611;670745;671164;671685;671802;47795.805104872656;48105;48669.756651216514;49029.754851225516;49034;39001.6099838998;51490;52072.73963630158;52105.218421724465;52708.47291527036;42294.15411691687;42756.57243427526;42901.570984289756;43155.568444315155;45167;39104.2179156421;42836.78581607072;42859.57140428556;43094.78452607717;44720.55279447164;38954.80522597369;39243.607563925136;39310.01724956899;39439;39544.01139971524;34297.48553771646;37399.813000934824;37483.62516374911;37890.8105459471;38196.04509887275;27531;27567.07307928805;27588;27646;27918.3020424491 15:07:17 INFO - PROCESS | 1643 | |2;jquery.html;336.05233242256844;341.46390167437124;380.94285857121446;394.87166670831976;414.074543395511;16024.359025638974;20909.686354704674;20952;21680.241191558278;21883.452913677167;20771.792282077175;21106.788932110674;21274.46813829655;21331;21424.14303427861;4978.153713868633;5163.741812909339;5844.649321040741;6043.123747056674;6075.027995520718;5283.63014588979;6046.425589569006;6136.325004249529;6141.2937512186;6149.969250153766;5879.187139340429;5951.821445356646;5954.910676339859;5974.462298393144;5975.790847320344;5682.6306290091015;5945.940540594582;5988.1317209004665;6043.848903777397;6065.727042283086;5130.871728206787;5175.715335656538;5180.300659410969;5183.092958732207;5199.844004679866;25297.98808047676;25465.504893769383;25466;25703;25857.965681372723;2435.257246539805;2470.9135180268604;2474;2513.459606184679;2540.7840333571485;15242.695146097127;15583.454579089677;15836.920815395964;16347;16457.753133703005;1895.5640202753307;1903.2387045182038;1937.0798870536523;1940.0299850074962;1954.3746001279596;64434.3556564433;80412.19587804105;80482.55404426767;130775.34612326973;133919;10799;10949.233553651167;11206.103511719042;11241.269317494336;11364.94317528407;13996.930015350063;14096;14104.788428173586;14113.01208915366;14165.78751318731;7420.220876807965;8721.825563488695;8975.213020869676;9099.272058235325;9174.036726143791;8490.150984901584;8738.126187381338;9337.066293370744;9342.719718408458;9428.90571094294;6713.160854893138;6879.6560171991205;6897.862042759117;6898.241193468714;7012;1859.479345783183;1898.686716691758;1902.2771346888094;1923.249932526316;1924.7209154672773;887.7691800132012;936.6628013914985;970.0348153587225;1039.1946241662772;1039.3400190878695;21783.564328713335;22442;22446.887765561067;22468.10127594878;22499.43751406228;1021.4943602916604;1037.180627304421;1057.7408534908843;1111.8332250162377;1130.8021096308278;11409.771804563863;11668.824967625493;11842.111841611913;11906.46420911061;11973.46119424628;639696;647210;650463;650602;652014;95845;102277.48861255647;103875.96124038663;120484.39757801154;128128;982.4400091947522;998.83519219328;1020.806046851096;1021.2187676427538;1023.0127926550765;19743.922621820526;20645.58708825845;20655.483612909797;20671.586568268853;20724.896375518027;52771.680707981075;53554.66113347198;54313;54325.72837135789;55769;71824;71952;73028;77227.61386193258;78206;8014.398920080901;8078;8181.79545511367;8234.917650823416;8235.794105147419;13068.869311306766;13314.866851331362;13358.064935454426;13432.932835335761;13723.725525489634;10876;11383.772324553629;11429.314241145225;11581.305121692725;11923.344216067853;9459.810803784023;11185.496652650487;11394.715132121763;11708;11840.05279577649;11643.708907277385;11651.242669226473;11883.584074557695;12006.039516838806;12054.09594280415;7985.720499782712;8016.519008859487;8189.79525511867;8242.670293188445;8268.214519620626;11482.368469734245;11677.824832627348;11698;11704.356260405759;11913.583024594098 15:07:17 INFO - PROCESS | 1643 | |3;mootools.html;1550.844915508449;1595.8643515301196;1601.2634188273394;1906;1954.4527532290963;8259.132791056927;8517.659293628263;8822.60298286577;9369.90630093699;9379;7805.297523222909;9076.591553380098;9078.954605226982;9193.172614464696;9227.492487913161;2419.794317483016;2458.0782206672498;2467.395488105408;2468.271859801363;2470.1231062972565;2389.392410223776;2460.274219105368;2461.852288862674;2463.3718401807514;2486.0304481252324;1969.5863868587614;2052.8460365472574;2059.567490826928;2440.5240978009297;2668.933276668089;2395.688560487143;2398.5442765874427;2406.1578447543393;2414.6257330113685;2426.8543887366814;2423.2730180945823;2425.4057755849753;2447.155731272708;2450.7916827069544;2451.2156110044793;8689.913100869036;9323.906760932372;9403.670871519533;9410.90589094114;9425.38734982224;5484.808031718871;5619.438056194348;5621.18492818539;5631.18347839561;5685.573581981368;3647.5622925248877;3673.448982652597;3705.9993801673395;3723.3484140275614;3761.586225515191;1014.1582486536157;1101.372217835834;1104.5526561742506;1106.0432725692299;1108.9778204435866;11896.04831613469;11943.522259109539;12007.57973470933;12013.219140755822;12210.206336588182;4541.636669066466;4545.545445455494;4730.787114579852;4731.858044258678;4774.4509381420885;9511.714648560554;9525.380850244712;9527.09492598202;9538.570764315622;9540.904590954002;5456.045192091368;5464.453554644504;5466.808661696821;5472;5477.75350109246;4570.337301091323;4711.0342379812055;4975.179095449283;5068.290439338495;5082.415522214918;3875.748076375027;3918.3730603103368;4001.9399709004388;4005.178938317638;4043.211573743092;1112.8482021108114;1143.8798926112804;1184.1237484261585;1202.8736982616874;1210.2798834693344;786.5123623353558;876.5310558850985;888.2405543260419;909.7088931541844;916.244098618629;5441.156620723794;5610.4670056344585;6069.484093852072;6100.298465676416;6190.288116866618;936.639393833379;944.2823454174877;948.4356807699546;968.2786324188384;974.6832279509188;3600.1539638185004;4001.5398229203433;4021.4772079630047;4030.1536677298095;4048.716589838742;10369.170466362673;10830.079443247254;10839.83740243897;10852.403117828595;10855.565777368816;10626.681199564026;10723.94638026805;10759.623413180658;10785.029347358775;10848.294860834021;7142.392896603847;8326.625301861432;8352.916470835215;8610.913890861011;8637;5842.941570584239;5893.233879595625;5922.73347699346;6061.818145455643;6081.087836824512;10123.088921997056;10337.37975721459;10479.842802357818;10480.737981550523;10520.842187367349;9996.550155242887;10366.637167699095;10388.844167337647;10612.257142000295;10616.52225649863;7097.290270972861;7280.708771649075;7514.173440921385;7646.847063058819;7841.372690184658;6910.928806035073;8495.575221238789;8613.09562495929;8789.956050219707;8809.251213646656;6723.798286051427;7383.630818459163;7679.155292917663;7692.269234422721;7999.720009799629;7269.7455589054125;7592.8481430372185;7713.074431068308;7744.57404842739;7810.570418626803;6180.227471566054;6780.898286525608;7246.746363877239;7260.745873894389;7264.418846492163;4418.668599854959;4967.528084831935;5006.624503162205;5062.873428164326;5208.791648334176;4994.450610432777;5006.499350064964;5119.923201151912;5133.153029750199;5179.948200517946 15:07:17 INFO - PROCESS | 1643 | |4;prototype.html;311.8238195419588;318.4888254351765;319.286394907382;320.2410287618345;323.6391423562728;5233.73831308435;5324.946750532494;5545.476808052336;5556.972215138919;5571.164325351199;5473.890522189564;5476.945230547693;5492.945070549294;5511.421300763413;5563.610547261694;4018.6584140348104;4118.567550407209;4126.823855201268;4146.668266538685;4225.6830737694645;3524.506569080331;4217.388478670591;4230.682698797587;4249.341352090415;4306.418633484471;4221.535631080578;4233.894152646178;4238.809253583596;4246.40550322955;4249;3477.3045390921666;4076.9184616307507;4208.284591619432;4223.239816832969;4228.027553662644;3027.742641875443;3040.255137491307;3606.7097393155536;3629.457480570747;3649.233660931208;4643.767811609406;5378.193271009341;5381.273528073699;5435.728213589345;5441.863953401157;4247.129338485603;4443.222985633979;4591.632669386441;4836.322914791932;4868;4768.666193366465;5145.893632868913;5297.993381257549;5918.526517878559;5919.970400147971;3475.200703838106;3764.7576299821267;3788.5264341957254;4097.508299004109;4106.527749308838;5315.362156541201;5798.217240672498;6087.817365479087;6097.481714054311;6119.388061193845;3466.1282907229815;3625.3111908737255;4143.129942712064;4143.97489832424;4164.562720914321;4225.830966761357;4226.281532139544;4233.745975241495;4242.96337757878;4254.914901702011;4102.692298077596;4578.40480737502;4851.738547977551;4881.585065269492;5011.123053465629;4841.806327746851;4861.829835955725;5173.534381905646;5508.641938274;5937.495312898365;1213.9453724582415;1365.7200273944015;1408.60559043468;1412.5903487988369;1414.8160739104057;763.3740332926947;808.975730728079;835.708829857871;848.4909054567333;853.5433543054436;4503.635591314521;4911.705297682151;5362.276092727432;5608.887822243532;5648.406917273709;5069.264956581275;5880.94119058804;6041.879162416727;6154.3845615438095;6195.597286176384;4689.742064186503;5335.973320133375;5445.891082178334;5619.129034999582;5632.718748906699;3065.816051036945;3189.8086114833186;3197.9840100799347;3206.278587317835;3214.8874789382726;4951.8266860659705;5158.045761534128;5773.566982476331;6381.968090159519;6411.647359395278;5272.947270527322;5460.836174914759;5906.9620980761565;6259.935810912156;6295.670601877335;5351.411344752152;6061.696915154224;6332.271788744353;6414.550981431348;6422.4862011039;5586.0673146598365;5883.499902508334;5981.730822112929;6012.248468941382;6104.847378815565;5506.779728810803;5978.671173085522;6043.8186854394435;6053.757849685963;6075.331713511422;5964.7912323068485;6310.242770867525;6348.269948955929;6355.777547785805;6366.586171898812;3379.7465190110347;3989.501312335958;4001.599840015975;4036.253293140778;4040.9393859092725;5110.926705391761;5557.221689059462;6047.78832740852;6131.386861313833;6162.705831775377;4974;5345.705986170798;5526.336839579116;5928.9407105928385;5952.910706339495;5877.794277200277;5938.2280303560265;5943.613665111754;5966.49284810796;5994.310654274815;5729.3124825019595;5775.653460792366;5806.883862322646;5807.796727114531;5838.824835254949;5286.762095705625;5542.972285138549;5886.381929897299;5922.230110085661;5944;4699.436067671902;5235.89528209426;5246.563500906912;5762.222100016612;5768.942310577008 15:07:17 INFO - PROCESS | 1643 | |5;yui.html;719.2699410098751;774.7482068327795;785.2187073861508;797.8484088023275;845.337187858246;15467.071975681452;16331.265093070811;16786.244618992143;16848.91575542122;16874.325026998937;14854.405823767063;14939.477118300862;15040.849591504082;15120.092794432341;15188.620284492894;580.9883802323951;726.0053726394847;863.18429084515;869.695606537713;890.955452227386;878.3105262369041;906.5648488725383;908.1327332397577;908.6365453818493;909.0228004894732;922.3174850610567;932.5570354081825;965.7489052846275;968.7142293023539;972.5040229482979;917.1653795046476;918.7106061590578;919.0212423768698;949.0319873728758;963.3160456076195;713.20477667401;722.5303552690741;723.2586598736285;723.3309189000154;726.0996364508024;14497.985141040132;14499.347529361205;14513.984021118526;14520.346584403727;14521.12873227599;15011.549653510412;15012.249387530579;15016;15118.319675614624;15141.545753627299;11948.103892208119;11952.820707689392;12114.454849531792;12328.568500102543;12441.3779311035;3114.672959339282;3843.8654647087496;3847.3459511883048;3950.111224974358;3966.147278335172;122282.38858805738;126803;126811;128182;129574;11373.260738052;11711.355875426932;11733.4719937603;11776.646700598996;11808.822867656992;23760.287191384286;23988.280351589132;24042.038318467065;24115.517689646458;24277.150299739424;8175.795605109801;8333.916660833314;8336;8346.040205376337;8445.1977062179;4428.158649856517;4488.483824360175;4488.663350248745;4489.326601009875;4614.377059097046;3563.6080031196548;3670.5778835434267;3673.173535954389;3699.7780133192095;3705.981470092632;702.3468174597571;735.5513136986434;738.4867517075688;740.6852087862637;746.7983644415978;544.4038777538589;598.9847208980735;619.8481372063874;672.7140965089817;676.9323067693191;8888.24449921751;9400.576974036048;9470.289728270407;9574.521273936276;9624.51877406127;612.4457366083701;661.4014317043084;672.7040102354948;672.9629870357178;693.2616763147232;4446.888827779331;4546.249868771615;4598.862034138914;4620.930686039712;4628.699134556243;117993.410032951;140769;177380;178721.1063944672;184391;147616;147781;147949.52050479356;149849.50150498573;152289;127555;127647;130162.34918825346;131105;131486.34256828847;8739.694110706349;8998.865017024618;9022.639094436148;9023.503707295898;9063.728088157366;58870.41129588649;68098.9785153233;68506.65746671235;69886;70946.64526677334;86216.56891715502;86627.56686216529;88876;95787.52106239424;97510;13302.733945321233;13947.16317020982;14017.369218385402;14110.576682699535;14293.213873237071;15088.849111508744;15103.244837758288;15220.777411184003;15317.234138293265;15784;14406.495772647908;14495.492657756928;14618.634534136307;14741.778873317124;15478.5356439307;13781;14273.857261427253;14442.638934026734;14461.13233206011;15062.698746025237;11751.236169649288;11900.464479098287;12607.810882836948;14211.928940355232;14231.71536569242;10833.404162771123;11187.72030699239;11413.771724565628;11915.582954596548;11959.76080478403;11825.940870295593;11897.821532676844;11969.760604788029;12052.09609279325;12089.697757556132 15:07:17 INFO - PROCESS | 1643 | __end_tp_report 15:07:17 INFO - PROCESS | 1643 | __start_cc_report 15:07:17 INFO - PROCESS | 1643 | _x_x_mozilla_cycle_collect,354 15:07:17 INFO - PROCESS | 1643 | __end_cc_report 15:07:17 INFO - PROCESS | 1643 | __startTimestamp1484003237467__endTimestamp 15:07:17 INFO - PROCESS | 1643 | 15:07:17 INFO - PROCESS | 1643 | ------- Summary: start ------- 15:07:17 INFO - PROCESS | 1643 | Number of tests: 6 15:07:17 INFO - PROCESS | 1643 | 15:07:17 INFO - PROCESS | 1643 | [#0] dojo.html Cycles:165 Average:5924.79 Median:6182.60 stddev:648.09 (10.5%) stddev-sans-first:623.67 15:07:17 INFO - PROCESS | 1643 | Values: 3590.7 3611.9 3622.5 3628.2 3667.4 6051.2 6087.0 6108.8 6113.3 6128.5 4675.6 6002.6 6042.2 6111.1 6190.3 5385.6 5472.1 5508.8 5541.8 5587.3 5536.3 5564.3 5567.7 5592.9 5634.1 5398.5 5414.4 5526.7 5552.1 5554.1 4475.9 5432.4 5498.3 5537.6 5586.6 5343.6 5471.7 5474.5 5498.6 5527.6 5873.6 6060.9 6099.9 6156.1 6199.6 5283.8 6218.3 6263.9 6272.9 6326.8 6384.3 6385.1 6406.3 6499.2 6539.7 6174.0 6180.6 6191.1 6211.6 6219.5 5314.7 5593.6 6439.0 6449.9 6497.1 4719.4 5336.2 6130.3 6288.4 6314.1 5824.6 6233.4 6296.6 6453.7 6475.2 5577.0 6232.7 6253.6 6255.5 6360.6 6036.2 6242.8 6276.0 6306.1 6339.0 4433.2 5055.9 5175.4 5190.5 5206.6 4597.4 4607.5 4637.0 4673.1 4691.3 6144.3 6158.5 6237.3 6238.3 6248.3 6415.3 6423.3 6428.9 6447.5 6462.3 6075.9 6108.8 6119.1 6120.1 6147.0 5678.5 5682.4 5694.2 5703.6 5720.1 6648.5 6668.2 6679.9 6682.7 6706.2 6188.9 6279.2 6289.8 6290.7 6410.0 6626.3 6651.3 6661.3 6661.9 6693.4 6332.9 6347.1 6355.7 6356.2 6362.1 6250.9 6294.1 6318.8 6375.1 6405.5 5284.0 6182.6 6278.7 6288.9 6312.1 6129.2 6300.5 6308.4 6312.4 6409.6 5978.3 6136.5 6176.3 6213.5 6246.4 6164.1 6199.4 6240.3 6261.7 6337.3 6222.2 6237.5 6257.8 6270.5 6276.7 15:07:17 INFO - PROCESS | 1643 | 15:07:17 INFO - PROCESS | 1643 | [#1] ext.html Cycles:180 Average:77162.72 Median:39374.51 stddev:174268.99 (442.6%) stddev-sans-first:174662.79 15:07:17 INFO - PROCESS | 1643 | Values: 495.9 534.2 540.6 541.2 567.2 41446.6 43479.0 43488.8 45688.8 45711.5 44556.9 45073.3 45084.9 45167.0 45230.1 9943.2 10109.3 10115.8 10133.5 10157.9 9879.7 9950.6 10008.3 10011.9 10022.5 9960.9 10005.4 10007.7 10012.5 10027.5 9912.7 9959.2 9986.6 9988.0 10027.0 7796.2 9813.0 9819.9 9894.8 10012.6 35600.5 35785.6 42334.9 42449.4 42740.0 3302.8 3418.8 3470.9 4165.4 4216.3 26627.6 31235.5 32295.8 32368.8 32916.5 3348.7 3360.9 3400.5 3407.1 3410.6 468798.0 537452.0 545348.0 546984.0 547569.0 34159.8 61261.0 61304.2 61579.7 61636.7 34512.0 36531.9 36928.0 37012.4 37150.3 15757.6 15957.0 15962.9 15970.6 16003.4 13305.7 13316.5 13348.1 13408.8 13419.2 7947.2 7970.7 8028.1 8138.2 8138.2 3394.4 3404.5 3430.3 3432.8 3443.3 972.7 979.8 988.5 1041.0 1060.9 31549.4 31642.7 31732.0 31856.2 32053.8 1056.1 1072.5 1112.6 1130.2 1138.2 15567.7 16557.7 16567.3 16634.7 16671.7 723451.0 730682.0 731189.0 741172.0 744101.0 60801.5 61413.4 61583.7 61590.4 61646.0 1384.5 1427.1 1431.6 1442.3 1445.7 30136.7 33584.8 33929.5 33973.5 35211.6 58978.7 59812.0 59853.4 63803.4 63915.0 658611.0 670745.0 671164.0 671685.0 671802.0 47795.8 48105.0 48669.8 49029.8 49034.0 39001.6 51490.0 52072.7 52105.2 52708.5 42294.2 42756.6 42901.6 43155.6 45167.0 39104.2 42836.8 42859.6 43094.8 44720.6 38954.8 39243.6 39310.0 39439.0 39544.0 34297.5 37399.8 37483.6 37890.8 38196.0 27531.0 27567.1 27588.0 27646.0 27918.3 15:07:17 INFO - PROCESS | 1643 | 15:07:17 INFO - PROCESS | 1643 | [#2] jquery.html Cycles:180 Average:35727.84 Median:2453.09 stddev:106955.23 (4360.0%) stddev-sans-first:107222.25 15:07:17 INFO - PROCESS | 1643 | Values: 336.1 341.5 380.9 394.9 414.1 16024.4 20909.7 20952.0 21680.2 21883.5 20771.8 21106.8 21274.5 21331.0 21424.1 4978.2 5163.7 5844.6 6043.1 6075.0 5283.6 6046.4 6136.3 6141.3 6150.0 5879.2 5951.8 5954.9 5974.5 5975.8 5682.6 5945.9 5988.1 6043.8 6065.7 5130.9 5175.7 5180.3 5183.1 5199.8 25298.0 25465.5 25466.0 25703.0 25858.0 2435.3 2470.9 2474.0 2513.5 2540.8 15242.7 15583.5 15836.9 16347.0 16457.8 1895.6 1903.2 1937.1 1940.0 1954.4 64434.4 80412.2 80482.6 130775.3 133919.0 10799.0 10949.2 11206.1 11241.3 11364.9 13996.9 14096.0 14104.8 14113.0 14165.8 7420.2 8721.8 8975.2 9099.3 9174.0 8490.2 8738.1 9337.1 9342.7 9428.9 6713.2 6879.7 6897.9 6898.2 7012.0 1859.5 1898.7 1902.3 1923.2 1924.7 887.8 936.7 970.0 1039.2 1039.3 21783.6 22442.0 22446.9 22468.1 22499.4 1021.5 1037.2 1057.7 1111.8 1130.8 11409.8 11668.8 11842.1 11906.5 11973.5 639696.0 647210.0 650463.0 650602.0 652014.0 95845.0 102277.5 103876.0 120484.4 128128.0 982.4 998.8 1020.8 1021.2 1023.0 19743.9 20645.6 20655.5 20671.6 20724.9 52771.7 53554.7 54313.0 54325.7 55769.0 71824.0 71952.0 73028.0 77227.6 78206.0 8014.4 8078.0 8181.8 8234.9 8235.8 13068.9 13314.9 13358.1 13432.9 13723.7 10876.0 11383.8 11429.3 11581.3 11923.3 9459.8 11185.5 11394.7 11708.0 11840.1 11643.7 11651.2 11883.6 12006.0 12054.1 7985.7 8016.5 8189.8 8242.7 8268.2 11482.4 11677.8 11698.0 11704.4 11913.6 15:07:17 INFO - PROCESS | 1643 | 15:07:17 INFO - PROCESS | 1643 | [#3] mootools.html Cycles:180 Average:5800.15 Median:5006.56 stddev:3258.11 (65.1%) stddev-sans-first:3251.60 15:07:17 INFO - PROCESS | 1643 | Values: 1550.8 1595.9 1601.3 1906.0 1954.5 8259.1 8517.7 8822.6 9369.9 9379.0 7805.3 9076.6 9079.0 9193.2 9227.5 2419.8 2458.1 2467.4 2468.3 2470.1 2389.4 2460.3 2461.9 2463.4 2486.0 1969.6 2052.8 2059.6 2440.5 2668.9 2395.7 2398.5 2406.2 2414.6 2426.9 2423.3 2425.4 2447.2 2450.8 2451.2 8689.9 9323.9 9403.7 9410.9 9425.4 5484.8 5619.4 5621.2 5631.2 5685.6 3647.6 3673.4 3706.0 3723.3 3761.6 1014.2 1101.4 1104.6 1106.0 1109.0 11896.0 11943.5 12007.6 12013.2 12210.2 4541.6 4545.5 4730.8 4731.9 4774.5 9511.7 9525.4 9527.1 9538.6 9540.9 5456.0 5464.5 5466.8 5472.0 5477.8 4570.3 4711.0 4975.2 5068.3 5082.4 3875.7 3918.4 4001.9 4005.2 4043.2 1112.8 1143.9 1184.1 1202.9 1210.3 786.5 876.5 888.2 909.7 916.2 5441.2 5610.5 6069.5 6100.3 6190.3 936.6 944.3 948.4 968.3 974.7 3600.2 4001.5 4021.5 4030.2 4048.7 10369.2 10830.1 10839.8 10852.4 10855.6 10626.7 10723.9 10759.6 10785.0 10848.3 7142.4 8326.6 8352.9 8610.9 8637.0 5842.9 5893.2 5922.7 6061.8 6081.1 10123.1 10337.4 10479.8 10480.7 10520.8 9996.6 10366.6 10388.8 10612.3 10616.5 7097.3 7280.7 7514.2 7646.8 7841.4 6910.9 8495.6 8613.1 8790.0 8809.3 6723.8 7383.6 7679.2 7692.3 7999.7 7269.7 7592.8 7713.1 7744.6 7810.6 6180.2 6780.9 7246.7 7260.7 7264.4 4418.7 4967.5 5006.6 5062.9 5208.8 4994.5 5006.5 5119.9 5133.2 5179.9 15:07:17 INFO - PROCESS | 1643 | 15:07:17 INFO - PROCESS | 1643 | [#4] prototype.html Cycles:180 Average:4718.89 Median:5306.68 stddev:1473.40 (27.8%) stddev-sans-first:1439.93 15:07:17 INFO - PROCESS | 1643 | Values: 311.8 318.5 319.3 320.2 323.6 5233.7 5324.9 5545.5 5557.0 5571.2 5473.9 5476.9 5492.9 5511.4 5563.6 4018.7 4118.6 4126.8 4146.7 4225.7 3524.5 4217.4 4230.7 4249.3 4306.4 4221.5 4233.9 4238.8 4246.4 4249.0 3477.3 4076.9 4208.3 4223.2 4228.0 3027.7 3040.3 3606.7 3629.5 3649.2 4643.8 5378.2 5381.3 5435.7 5441.9 4247.1 4443.2 4591.6 4836.3 4868.0 4768.7 5145.9 5298.0 5918.5 5920.0 3475.2 3764.8 3788.5 4097.5 4106.5 5315.4 5798.2 6087.8 6097.5 6119.4 3466.1 3625.3 4143.1 4144.0 4164.6 4225.8 4226.3 4233.7 4243.0 4254.9 4102.7 4578.4 4851.7 4881.6 5011.1 4841.8 4861.8 5173.5 5508.6 5937.5 1213.9 1365.7 1408.6 1412.6 1414.8 763.4 809.0 835.7 848.5 853.5 4503.6 4911.7 5362.3 5608.9 5648.4 5069.3 5880.9 6041.9 6154.4 6195.6 4689.7 5336.0 5445.9 5619.1 5632.7 3065.8 3189.8 3198.0 3206.3 3214.9 4951.8 5158.0 5773.6 6382.0 6411.6 5272.9 5460.8 5907.0 6259.9 6295.7 5351.4 6061.7 6332.3 6414.6 6422.5 5586.1 5883.5 5981.7 6012.2 6104.8 5506.8 5978.7 6043.8 6053.8 6075.3 5964.8 6310.2 6348.3 6355.8 6366.6 3379.7 3989.5 4001.6 4036.3 4040.9 5110.9 5557.2 6047.8 6131.4 6162.7 4974.0 5345.7 5526.3 5928.9 5952.9 5877.8 5938.2 5943.6 5966.5 5994.3 5729.3 5775.7 5806.9 5807.8 5838.8 5286.8 5543.0 5886.4 5922.2 5944.0 4699.4 5235.9 5246.6 5762.2 5768.9 15:07:17 INFO - PROCESS | 1643 | 15:07:17 INFO - PROCESS | 1643 | [#5] yui.html Cycles:180 Average:27152.59 Median:3339.14 stddev:44545.10 (1334.0%) stddev-sans-first:44625.85 15:07:17 INFO - PROCESS | 1643 | Values: 719.3 774.7 785.2 797.8 845.3 15467.1 16331.3 16786.2 16848.9 16874.3 14854.4 14939.5 15040.8 15120.1 15188.6 581.0 726.0 863.2 869.7 891.0 878.3 906.6 908.1 908.6 909.0 922.3 932.6 965.7 968.7 972.5 917.2 918.7 919.0 949.0 963.3 713.2 722.5 723.3 723.3 726.1 14498.0 14499.3 14514.0 14520.3 14521.1 15011.5 15012.2 15016.0 15118.3 15141.5 11948.1 11952.8 12114.5 12328.6 12441.4 3114.7 3843.9 3847.3 3950.1 3966.1 122282.4 126803.0 126811.0 128182.0 129574.0 11373.3 11711.4 11733.5 11776.6 11808.8 23760.3 23988.3 24042.0 24115.5 24277.2 8175.8 8333.9 8336.0 8346.0 8445.2 4428.2 4488.5 4488.7 4489.3 4614.4 3563.6 3670.6 3673.2 3699.8 3706.0 702.3 735.6 738.5 740.7 746.8 544.4 599.0 619.8 672.7 676.9 8888.2 9400.6 9470.3 9574.5 9624.5 612.4 661.4 672.7 673.0 693.3 4446.9 4546.2 4598.9 4620.9 4628.7 117993.4 140769.0 177380.0 178721.1 184391.0 147616.0 147781.0 147949.5 149849.5 152289.0 127555.0 127647.0 130162.3 131105.0 131486.3 8739.7 8998.9 9022.6 9023.5 9063.7 58870.4 68099.0 68506.7 69886.0 70946.6 86216.6 86627.6 88876.0 95787.5 97510.0 13302.7 13947.2 14017.4 14110.6 14293.2 15088.8 15103.2 15220.8 15317.2 15784.0 14406.5 14495.5 14618.6 14741.8 15478.5 13781.0 14273.9 14442.6 14461.1 15062.7 11751.2 11900.5 12607.8 14211.9 14231.7 10833.4 11187.7 11413.8 11915.6 11959.8 11825.9 11897.8 11969.8 12052.1 12089.7 15:07:17 INFO - PROCESS | 1643 | -------- Summary: end -------- 15:07:17 INFO - PROCESS | 1643 | 15:07:18 INFO - TEST-INFO | 1643: exit 0 15:07:18 INFO - TEST-OK | dromaeo_css | took 1111668ms 15:07:18 INFO - TEST-START | kraken 15:07:18 INFO - operating with platform_type : mac_ 15:07:18 INFO - Initialising browser for kraken test... 15:07:18 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/tmpJDaLYv/profile http://localhost:49241/getInfo.html) 15:07:20 INFO - PROCESS | 1655 | __metrics Screen width/height:1600/1200 15:07:20 INFO - PROCESS | 1655 | colorDepth:24 15:07:20 INFO - PROCESS | 1655 | Browser inner width/height: 1024/689 15:07:20 INFO - PROCESS | 1655 | __metrics 15:07:20 ERROR - PROCESS | 1655 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3015: TypeError: this.tabs is undefined 15:07:20 INFO - TEST-INFO | 1655: exit 0 15:07:20 INFO - Browser initialized. 15:07:20 INFO - Running cycle 1/1 for kraken test... 15:07:20 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/tmpJDaLYv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:07:32 INFO - PROCESS | 1658 | RSS: Main: 175357952 15:07:32 INFO - PROCESS | 1658 | 15:07:35 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 15:07:36 INFO - PROCESS | 1658 | RSS: Main: 187211776 15:07:36 INFO - PROCESS | 1658 | 15:07:39 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 15:07:39 INFO - PROCESS | 1658 | RSS: Main: 195686400 15:07:39 INFO - PROCESS | 1658 | 15:07:43 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 15:07:43 INFO - PROCESS | 1658 | RSS: Main: 198938624 15:07:43 INFO - PROCESS | 1658 | 15:07:45 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 15:07:46 INFO - PROCESS | 1658 | RSS: Main: 198922240 15:07:46 INFO - PROCESS | 1658 | 15:07:48 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:07:48 INFO - PROCESS | 1658 | RSS: Main: 199004160 15:07:48 INFO - PROCESS | 1658 | 15:07:51 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 15:07:52 INFO - PROCESS | 1658 | RSS: Main: 200085504 15:07:52 INFO - PROCESS | 1658 | 15:07:55 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 15:07:56 INFO - PROCESS | 1658 | RSS: Main: 201232384 15:07:56 INFO - PROCESS | 1658 | 15:07:59 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 15:07:59 INFO - PROCESS | 1658 | RSS: Main: 201580544 15:07:59 INFO - PROCESS | 1658 | 15:08:01 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:08:01 INFO - PROCESS | 1658 | RSS: Main: 200646656 15:08:01 INFO - PROCESS | 1658 | 15:08:03 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:08:04 INFO - PROCESS | 1658 | RSS: Main: 200716288 15:08:04 INFO - PROCESS | 1658 | 15:08:06 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:08:07 INFO - PROCESS | 1658 | RSS: Main: 200765440 15:08:07 INFO - PROCESS | 1658 | 15:08:10 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:08:11 INFO - PROCESS | 1658 | RSS: Main: 201150464 15:08:11 INFO - PROCESS | 1658 | 15:08:14 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:08:14 INFO - PROCESS | 1658 | RSS: Main: 201134080 15:08:14 INFO - PROCESS | 1658 | 15:08:16 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 15:08:16 INFO - PROCESS | 1658 | RSS: Main: 202735616 15:08:16 INFO - PROCESS | 1658 | 15:08:16 INFO - PROCESS | 1658 | __start_tp_report 15:08:16 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 15:08:16 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 15:08:16 INFO - PROCESS | 1658 | |i|pagename|runs| 15:08:16 INFO - PROCESS | 1658 | |0;ai-astar;106;116;116;116;117;151;98;168;168;167 15:08:16 INFO - PROCESS | 1658 | |1;audio-beat-detection;139;109;109;142;109;108;104;110;133;136 15:08:16 INFO - PROCESS | 1658 | |2;audio-dft;194;236;255;195;197;194;197;185;200;271 15:08:16 INFO - PROCESS | 1658 | |3;audio-fft;80;61;61;82;59;59;59;59;75;59 15:08:16 INFO - PROCESS | 1658 | |4;audio-oscillator;84;67;84;80;94;67;81;75;99;117 15:08:16 INFO - PROCESS | 1658 | |5;imaging-gaussian-blur;89;101;88;111;133;106;89;85;87;97 15:08:16 INFO - PROCESS | 1658 | |6;imaging-darkroom;150;132;103;106;149;148;117;96;96;94 15:08:16 INFO - PROCESS | 1658 | |7;imaging-desaturate;91;91;89;91;123;140;83;131;143;135 15:08:16 INFO - PROCESS | 1658 | |8;json-parse-financial;54;55;56;55;59;59;64;69;77;85 15:08:16 INFO - PROCESS | 1658 | |9;json-stringify-tinderbox;54;89;61;86;106;102;94;73;63;83 15:08:16 INFO - PROCESS | 1658 | |10;stanford-crypto-aes;81;85;76;100;96;99;71;94;76;91 15:08:16 INFO - PROCESS | 1658 | |11;stanford-crypto-ccm;136;158;151;137;156;154;141;173;193;169 15:08:16 INFO - PROCESS | 1658 | |12;stanford-crypto-pbkdf2;163;216;163;160;166;204;163;163;159;146 15:08:16 INFO - PROCESS | 1658 | |13;stanford-crypto-sha256-iterative;68;66;74;80;79;67;66;66;67;67 15:08:16 INFO - PROCESS | 1658 | __end_tp_report 15:08:16 INFO - PROCESS | 1658 | __start_cc_report 15:08:16 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,907 15:08:16 INFO - PROCESS | 1658 | __end_cc_report 15:08:16 INFO - PROCESS | 1658 | __startTimestamp1484003296590__endTimestamp 15:08:16 INFO - PROCESS | 1658 | 15:08:16 INFO - PROCESS | 1658 | ------- Summary: start ------- 15:08:16 INFO - PROCESS | 1658 | Number of tests: 14 15:08:16 INFO - PROCESS | 1658 | 15:08:16 INFO - PROCESS | 1658 | [#0] ai-astar Cycles:10 Average:132.30 Median:159.00 stddev:27.89 (17.5%) stddev-sans-first:27.91 15:08:16 INFO - PROCESS | 1658 | Values: 106.0 116.0 116.0 116.0 117.0 151.0 98.0 168.0 168.0 167.0 15:08:16 INFO - PROCESS | 1658 | 15:08:16 INFO - PROCESS | 1658 | [#1] audio-beat-detection Cycles:10 Average:119.90 Median:121.50 stddev:15.39 (12.7%) stddev-sans-first:14.70 15:08:16 INFO - PROCESS | 1658 | Values: 139.0 109.0 109.0 142.0 109.0 108.0 104.0 110.0 133.0 136.0 15:08:16 INFO - PROCESS | 1658 | 15:08:16 INFO - PROCESS | 1658 | [#2] audio-dft Cycles:10 Average:212.40 Median:198.50 stddev:30.12 (15.2%) stddev-sans-first:31.20 15:08:16 INFO - PROCESS | 1658 | Values: 194.0 236.0 255.0 195.0 197.0 194.0 197.0 185.0 200.0 271.0 15:08:16 INFO - PROCESS | 1658 | 15:08:16 INFO - PROCESS | 1658 | [#3] audio-fft Cycles:10 Average:65.40 Median:61.00 stddev:9.57 (15.7%) stddev-sans-first:8.57 15:08:16 INFO - PROCESS | 1658 | Values: 80.0 61.0 61.0 82.0 59.0 59.0 59.0 59.0 75.0 59.0 15:08:16 INFO - PROCESS | 1658 | 15:08:16 INFO - PROCESS | 1658 | [#4] audio-oscillator Cycles:10 Average:84.80 Median:82.50 stddev:15.24 (18.5%) stddev-sans-first:16.17 15:08:16 INFO - PROCESS | 1658 | Values: 84.0 67.0 84.0 80.0 94.0 67.0 81.0 75.0 99.0 117.0 15:08:16 INFO - PROCESS | 1658 | 15:08:16 INFO - PROCESS | 1658 | [#5] imaging-gaussian-blur Cycles:10 Average:98.60 Median:87.50 stddev:14.97 (17.1%) stddev-sans-first:15.47 15:08:16 INFO - PROCESS | 1658 | Values: 89.0 101.0 88.0 111.0 133.0 106.0 89.0 85.0 87.0 97.0 15:08:16 INFO - PROCESS | 1658 | 15:08:16 INFO - PROCESS | 1658 | [#6] imaging-darkroom Cycles:10 Average:119.10 Median:149.50 stddev:23.53 (15.7%) stddev-sans-first:22.14 15:08:16 INFO - PROCESS | 1658 | Values: 150.0 132.0 103.0 106.0 149.0 148.0 117.0 96.0 96.0 94.0 15:08:16 INFO - PROCESS | 1658 | 15:08:16 INFO - PROCESS | 1658 | [#7] imaging-desaturate Cycles:10 Average:111.70 Median:86.00 stddev:24.60 (28.6%) stddev-sans-first:24.93 15:08:16 INFO - PROCESS | 1658 | Values: 91.0 91.0 89.0 91.0 123.0 140.0 83.0 131.0 143.0 135.0 15:08:16 INFO - PROCESS | 1658 | 15:08:16 INFO - PROCESS | 1658 | [#8] json-parse-financial Cycles:10 Average:63.30 Median:61.50 stddev:10.57 (17.2%) stddev-sans-first:10.67 15:08:16 INFO - PROCESS | 1658 | Values: 54.0 55.0 56.0 55.0 59.0 59.0 64.0 69.0 77.0 85.0 15:08:16 INFO - PROCESS | 1658 | 15:08:16 INFO - PROCESS | 1658 | [#9] json-stringify-tinderbox Cycles:10 Average:81.10 Median:78.00 stddev:17.78 (22.8%) stddev-sans-first:15.93 15:08:16 INFO - PROCESS | 1658 | Values: 54.0 89.0 61.0 86.0 106.0 102.0 94.0 73.0 63.0 83.0 15:08:16 INFO - PROCESS | 1658 | 15:08:16 INFO - PROCESS | 1658 | [#10] stanford-crypto-aes Cycles:10 Average:86.90 Median:88.00 stddev:10.52 (12.0%) stddev-sans-first:10.94 15:08:16 INFO - PROCESS | 1658 | Values: 81.0 85.0 76.0 100.0 96.0 99.0 71.0 94.0 76.0 91.0 15:08:16 INFO - PROCESS | 1658 | 15:08:16 INFO - PROCESS | 1658 | [#11] stanford-crypto-ccm Cycles:10 Average:156.80 Median:157.00 stddev:17.76 (11.3%) stddev-sans-first:17.17 15:08:16 INFO - PROCESS | 1658 | Values: 136.0 158.0 151.0 137.0 156.0 154.0 141.0 173.0 193.0 169.0 15:08:16 INFO - PROCESS | 1658 | 15:08:16 INFO - PROCESS | 1658 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.30 Median:163.00 stddev:21.81 (13.4%) stddev-sans-first:22.97 15:08:16 INFO - PROCESS | 1658 | Values: 163.0 216.0 163.0 160.0 166.0 204.0 163.0 163.0 159.0 146.0 15:08:16 INFO - PROCESS | 1658 | 15:08:16 INFO - PROCESS | 1658 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.00 Median:67.50 stddev:5.54 (8.2%) stddev-sans-first:5.83 15:08:16 INFO - PROCESS | 1658 | Values: 68.0 66.0 74.0 80.0 79.0 67.0 66.0 66.0 67.0 67.0 15:08:16 INFO - PROCESS | 1658 | -------- Summary: end -------- 15:08:16 INFO - PROCESS | 1658 | 15:08:17 INFO - TEST-INFO | 1658: exit 0 15:08:17 INFO - TEST-OK | kraken | took 59332ms 15:08:17 INFO - SUITE-END | took 1171s 15:08:17 INFO - Completed test suite (00:19:31) 15:08:17 INFO - javascript benchmark 15:08:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7586.030335990695, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3590.69479094277, 3611.873584424544, 3622.529071220741, 3628.2380700052995, 3667.3582123128444, 6051.183090282816, 6087.0, 6108.786192483264, 6113.327533971265, 6128.479079278261, 4675.579197872191, 6002.639841609506, 6042.244719410074, 6111.052786818039, 6190.288116866562, 5385.623006389545, 5472.1244600863865, 5508.807191748289, 5541.778328866841, 5587.329520457551, 5536.252605898213, 5564.304461942257, 5567.66594004359, 5592.916106258409, 5634.12671035988, 5398.514133727964, 5414.43148469411, 5526.696031718254, 5552.139418390156, 5554.1113421852515, 4475.865724028268, 5432.429594892538, 5498.3127109111365, 5537.556995440355, 5586.636868603528, 5343.572514198855, 5471.699056551888, 5474.452554744534, 5498.642588231752, 5527.613067085305, 5873.618214816023, 6060.909086363708, 6099.878002439927, 6156.106629883948, 6199.597026193283, 5283.788648454057, 6218.253809542839, 6263.874722505524, 6272.87454250917, 6326.778562750282, 6384.297727249998, 6385.138006369127, 6406.263279722845, 6499.2200935887995, 6539.738410463576, 6173.981293086636, 6180.6291622502795, 6191.071339299141, 6211.565190436717, 6219.47134493564, 5314.681119132864, 5593.580481463825, 6439.034144878212, 6449.871002579922, 6497.122888410098, 4719.4100737407825, 5336.17289320156, 6130.295016073209, 6288.371162883675, 6314.116023756677, 5824.621399609012, 6233.376662333821, 6296.622202667854, 6453.709583068773, 6475.158229430144, 5577.0, 6232.719527621268, 6253.624782513064, 6255.499560035186, 6360.554761166766, 6036.15493830864, 6242.812715618538, 6275.96862015687, 6306.148669929501, 6339.049142628643, 4433.224185767543, 5055.9494405055475, 5175.378954525406, 5190.532852043334, 5206.609504287194, 4597.42532183477, 4607.470140933769, 4637.0262244928945, 4673.135469938073, 4691.272852707768, 6144.293406258337, 6158.476529494954, 6237.345078766664, 6238.282597501346, 6248.250209974832, 6415.26224484181, 6423.2555816392605, 6428.871422571522, 6447.516436267299, 6462.289148193695, 6075.939240607626, 6108.786192483241, 6119.051547010132, 6120.081455037911, 6146.969265153645, 5678.545716342683, 5682.40334764852, 5694.174344719992, 5703.62926409782, 5720.08478643415, 6648.5346025777735, 6668.166479190101, 6679.899801502981, 6682.665866706645, 6706.195256569243, 6188.938110619017, 6279.246490421178, 6289.842753931189, 6290.716917738621, 6410.038494225903, 6626.271110177973, 6651.301613330531, 6661.300563440769, 6661.900071499028, 6693.397594216543, 6332.936670633235, 6347.111404403295, 6355.682215889095, 6356.237251529661, 6362.141110949962, 6250.937490625036, 6294.055891616111, 6318.810435686937, 6375.075614036032, 6405.519586030973, 5283.973580132075, 6182.598131121463, 6278.7488500461295, 6288.905666414916, 6312.084747711464, 6129.172561704113, 6300.495960323255, 6308.400701933309, 6312.400321969406, 6409.647469389042, 5978.282606087298, 6136.519078024374, 6176.258848938156, 6213.5339849510565, 6246.406591373812, 6164.137020816999, 6199.380061993765, 6240.251169859646, 6261.749530018748, 6337.271213810471, 6222.222222222223, 6237.500999919905, 6257.812265632038, 6270.467010304175, 6276.686165691606], "value": 5888.457927517516, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [495.8817865712817, 534.1773668550431, 540.6107602526182, 541.1909195752348, 567.2229046206696, 41446.58553414465, 43479.0, 43488.78255608718, 45688.77155614217, 45711.54288457114, 44556.88607784807, 45073.32390014144, 45084.87287817806, 45167.0, 45230.095398092104, 9943.154831839302, 10109.292349535535, 10115.797684046314, 10133.49332533374, 10157.898421015807, 9879.703608891745, 9950.601975920954, 10008.349457285289, 10011.899881001169, 10022.54898529568, 9960.850587241197, 10005.399676019462, 10007.699769006942, 10012.499375031255, 10027.548760305805, 9912.653057143001, 9959.15347195482, 9986.550605222783, 9988.001199880027, 10027.04743049409, 7796.181400952932, 9812.95093524535, 9819.90180098197, 9894.752631184207, 10012.59949602015, 35600.465993010126, 35785.64214357875, 42334.94162645928, 42449.36325955113, 42740.0, 3302.8018318900704, 3418.8461519231696, 3470.8958731238104, 4165.354370072643, 4216.2832318505925, 26627.600585991226, 31235.531467028013, 32295.838520807247, 32368.83815580907, 32916.50625240623, 3348.7153591944716, 3360.9354587135376, 3400.506926495669, 3407.0800883761244, 3410.6077801052948, 468798.0, 537452.0, 545348.0, 546984.0, 547569.0, 34159.829200854336, 61261.0, 61304.241309141195, 61579.69210153921, 61636.69181654063, 34512.0, 36531.904042878756, 36928.0, 37012.44481332782, 37150.25699485995, 15757.606059848595, 15957.0, 15962.920185398998, 15970.600734981486, 16003.359865605245, 13305.66735831612, 13316.467341306434, 13348.065635405623, 13408.798868016987, 13419.194848309133, 7947.245011723877, 7970.721024764105, 8028.07677117139, 8138.226868447488, 8138.226868447488, 3394.387665858747, 3404.472306792451, 3430.2967891582166, 3432.7597068205487, 3443.27691184854, 972.6595691508057, 979.8187335342842, 988.4563490080427, 1040.9798397570423, 1060.925735198544, 31549.36901261962, 31642.683573163973, 31732.04803855888, 31856.203594910312, 32053.839730801665, 1056.144522936424, 1072.453048945028, 1112.6383925224172, 1130.1749722702473, 1138.2430683595483, 15567.688646227012, 16557.668846623, 16567.337306507605, 16634.667306654042, 16671.6665666686, 723451.0, 730682.0, 731189.0, 741172.0, 744101.0, 60801.47996300128, 61413.38586614166, 61583.692081540205, 61590.38409615936, 61646.0, 1384.508499482669, 1427.1019544006447, 1431.5991522373752, 1442.2716528153217, 1445.7253121907015, 30136.698633013388, 33584.83207583946, 33929.49105763366, 33973.49039764455, 35211.64788352186, 58978.70510647419, 59812.0, 59853.40146598478, 63803.36196637974, 63915.0, 658611.0, 670745.0, 671164.0, 671685.0, 671802.0, 47795.805104872656, 48105.0, 48669.756651216514, 49029.754851225516, 49034.0, 39001.6099838998, 51490.0, 52072.73963630158, 52105.218421724465, 52708.47291527036, 42294.15411691687, 42756.57243427526, 42901.570984289756, 43155.568444315155, 45167.0, 39104.2179156421, 42836.78581607072, 42859.57140428556, 43094.78452607717, 44720.55279447164, 38954.80522597369, 39243.607563925136, 39310.01724956899, 39439.0, 39544.01139971524, 34297.48553771646, 37399.813000934824, 37483.62516374911, 37890.8105459471, 38196.04509887275, 27531.0, 27567.07307928805, 27588.0, 27646.0, 27918.3020424491], "value": 20151.540286529125, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.05233242256844, 341.46390167437124, 380.94285857121446, 394.87166670831976, 414.074543395511, 16024.359025638974, 20909.686354704674, 20952.0, 21680.241191558278, 21883.452913677167, 20771.792282077175, 21106.788932110674, 21274.46813829655, 21331.0, 21424.14303427861, 4978.153713868633, 5163.741812909339, 5844.649321040741, 6043.123747056674, 6075.027995520718, 5283.63014588979, 6046.425589569006, 6136.325004249529, 6141.2937512186, 6149.969250153766, 5879.187139340429, 5951.821445356646, 5954.910676339859, 5974.462298393144, 5975.790847320344, 5682.6306290091015, 5945.940540594582, 5988.1317209004665, 6043.848903777397, 6065.727042283086, 5130.871728206787, 5175.715335656538, 5180.300659410969, 5183.092958732207, 5199.844004679866, 25297.98808047676, 25465.504893769383, 25466.0, 25703.0, 25857.965681372723, 2435.257246539805, 2470.9135180268604, 2474.0, 2513.459606184679, 2540.7840333571485, 15242.695146097127, 15583.454579089677, 15836.920815395964, 16347.0, 16457.753133703005, 1895.5640202753307, 1903.2387045182038, 1937.0798870536523, 1940.0299850074962, 1954.3746001279596, 64434.3556564433, 80412.19587804105, 80482.55404426767, 130775.34612326973, 133919.0, 10799.0, 10949.233553651167, 11206.103511719042, 11241.269317494336, 11364.94317528407, 13996.930015350063, 14096.0, 14104.788428173586, 14113.01208915366, 14165.78751318731, 7420.220876807965, 8721.825563488695, 8975.213020869676, 9099.272058235325, 9174.036726143791, 8490.150984901584, 8738.126187381338, 9337.066293370744, 9342.719718408458, 9428.90571094294, 6713.160854893138, 6879.6560171991205, 6897.862042759117, 6898.241193468714, 7012.0, 1859.479345783183, 1898.686716691758, 1902.2771346888094, 1923.249932526316, 1924.7209154672773, 887.7691800132012, 936.6628013914985, 970.0348153587225, 1039.1946241662772, 1039.3400190878695, 21783.564328713335, 22442.0, 22446.887765561067, 22468.10127594878, 22499.43751406228, 1021.4943602916604, 1037.180627304421, 1057.7408534908843, 1111.8332250162377, 1130.8021096308278, 11409.771804563863, 11668.824967625493, 11842.111841611913, 11906.46420911061, 11973.46119424628, 639696.0, 647210.0, 650463.0, 650602.0, 652014.0, 95845.0, 102277.48861255647, 103875.96124038663, 120484.39757801154, 128128.0, 982.4400091947522, 998.83519219328, 1020.806046851096, 1021.2187676427538, 1023.0127926550765, 19743.922621820526, 20645.58708825845, 20655.483612909797, 20671.586568268853, 20724.896375518027, 52771.680707981075, 53554.66113347198, 54313.0, 54325.72837135789, 55769.0, 71824.0, 71952.0, 73028.0, 77227.61386193258, 78206.0, 8014.398920080901, 8078.0, 8181.79545511367, 8234.917650823416, 8235.794105147419, 13068.869311306766, 13314.866851331362, 13358.064935454426, 13432.932835335761, 13723.725525489634, 10876.0, 11383.772324553629, 11429.314241145225, 11581.305121692725, 11923.344216067853, 9459.810803784023, 11185.496652650487, 11394.715132121763, 11708.0, 11840.05279577649, 11643.708907277385, 11651.242669226473, 11883.584074557695, 12006.039516838806, 12054.09594280415, 7985.720499782712, 8016.519008859487, 8189.79525511867, 8242.670293188445, 8268.214519620626, 11482.368469734245, 11677.824832627348, 11698.0, 11704.356260405759, 11913.583024594098], "value": 9929.574640385266, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1550.844915508449, 1595.8643515301196, 1601.2634188273394, 1906.0, 1954.4527532290963, 8259.132791056927, 8517.659293628263, 8822.60298286577, 9369.90630093699, 9379.0, 7805.297523222909, 9076.591553380098, 9078.954605226982, 9193.172614464696, 9227.492487913161, 2419.794317483016, 2458.0782206672498, 2467.395488105408, 2468.271859801363, 2470.1231062972565, 2389.392410223776, 2460.274219105368, 2461.852288862674, 2463.3718401807514, 2486.0304481252324, 1969.5863868587614, 2052.8460365472574, 2059.567490826928, 2440.5240978009297, 2668.933276668089, 2395.688560487143, 2398.5442765874427, 2406.1578447543393, 2414.6257330113685, 2426.8543887366814, 2423.2730180945823, 2425.4057755849753, 2447.155731272708, 2450.7916827069544, 2451.2156110044793, 8689.913100869036, 9323.906760932372, 9403.670871519533, 9410.90589094114, 9425.38734982224, 5484.808031718871, 5619.438056194348, 5621.18492818539, 5631.18347839561, 5685.573581981368, 3647.5622925248877, 3673.448982652597, 3705.9993801673395, 3723.3484140275614, 3761.586225515191, 1014.1582486536157, 1101.372217835834, 1104.5526561742506, 1106.0432725692299, 1108.9778204435866, 11896.04831613469, 11943.522259109539, 12007.57973470933, 12013.219140755822, 12210.206336588182, 4541.636669066466, 4545.545445455494, 4730.787114579852, 4731.858044258678, 4774.4509381420885, 9511.714648560554, 9525.380850244712, 9527.09492598202, 9538.570764315622, 9540.904590954002, 5456.045192091368, 5464.453554644504, 5466.808661696821, 5472.0, 5477.75350109246, 4570.337301091323, 4711.0342379812055, 4975.179095449283, 5068.290439338495, 5082.415522214918, 3875.748076375027, 3918.3730603103368, 4001.9399709004388, 4005.178938317638, 4043.211573743092, 1112.8482021108114, 1143.8798926112804, 1184.1237484261585, 1202.8736982616874, 1210.2798834693344, 786.5123623353558, 876.5310558850985, 888.2405543260419, 909.7088931541844, 916.244098618629, 5441.156620723794, 5610.4670056344585, 6069.484093852072, 6100.298465676416, 6190.288116866618, 936.639393833379, 944.2823454174877, 948.4356807699546, 968.2786324188384, 974.6832279509188, 3600.1539638185004, 4001.5398229203433, 4021.4772079630047, 4030.1536677298095, 4048.716589838742, 10369.170466362673, 10830.079443247254, 10839.83740243897, 10852.403117828595, 10855.565777368816, 10626.681199564026, 10723.94638026805, 10759.623413180658, 10785.029347358775, 10848.294860834021, 7142.392896603847, 8326.625301861432, 8352.916470835215, 8610.913890861011, 8637.0, 5842.941570584239, 5893.233879595625, 5922.73347699346, 6061.818145455643, 6081.087836824512, 10123.088921997056, 10337.37975721459, 10479.842802357818, 10480.737981550523, 10520.842187367349, 9996.550155242887, 10366.637167699095, 10388.844167337647, 10612.257142000295, 10616.52225649863, 7097.290270972861, 7280.708771649075, 7514.173440921385, 7646.847063058819, 7841.372690184658, 6910.928806035073, 8495.575221238789, 8613.09562495929, 8789.956050219707, 8809.251213646656, 6723.798286051427, 7383.630818459163, 7679.155292917663, 7692.269234422721, 7999.720009799629, 7269.7455589054125, 7592.8481430372185, 7713.074431068308, 7744.57404842739, 7810.570418626803, 6180.227471566054, 6780.898286525608, 7246.746363877239, 7260.745873894389, 7264.418846492163, 4418.668599854959, 4967.528084831935, 5006.624503162205, 5062.873428164326, 5208.791648334176, 4994.450610432777, 5006.499350064964, 5119.923201151912, 5133.153029750199, 5179.948200517946], "value": 4653.0302072117665, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.8238195419588, 318.4888254351765, 319.286394907382, 320.2410287618345, 323.6391423562728, 5233.73831308435, 5324.946750532494, 5545.476808052336, 5556.972215138919, 5571.164325351199, 5473.890522189564, 5476.945230547693, 5492.945070549294, 5511.421300763413, 5563.610547261694, 4018.6584140348104, 4118.567550407209, 4126.823855201268, 4146.668266538685, 4225.6830737694645, 3524.506569080331, 4217.388478670591, 4230.682698797587, 4249.341352090415, 4306.418633484471, 4221.535631080578, 4233.894152646178, 4238.809253583596, 4246.40550322955, 4249.0, 3477.3045390921666, 4076.9184616307507, 4208.284591619432, 4223.239816832969, 4228.027553662644, 3027.742641875443, 3040.255137491307, 3606.7097393155536, 3629.457480570747, 3649.233660931208, 4643.767811609406, 5378.193271009341, 5381.273528073699, 5435.728213589345, 5441.863953401157, 4247.129338485603, 4443.222985633979, 4591.632669386441, 4836.322914791932, 4868.0, 4768.666193366465, 5145.893632868913, 5297.993381257549, 5918.526517878559, 5919.970400147971, 3475.200703838106, 3764.7576299821267, 3788.5264341957254, 4097.508299004109, 4106.527749308838, 5315.362156541201, 5798.217240672498, 6087.817365479087, 6097.481714054311, 6119.388061193845, 3466.1282907229815, 3625.3111908737255, 4143.129942712064, 4143.97489832424, 4164.562720914321, 4225.830966761357, 4226.281532139544, 4233.745975241495, 4242.96337757878, 4254.914901702011, 4102.692298077596, 4578.40480737502, 4851.738547977551, 4881.585065269492, 5011.123053465629, 4841.806327746851, 4861.829835955725, 5173.534381905646, 5508.641938274, 5937.495312898365, 1213.9453724582415, 1365.7200273944015, 1408.60559043468, 1412.5903487988369, 1414.8160739104057, 763.3740332926947, 808.975730728079, 835.708829857871, 848.4909054567333, 853.5433543054436, 4503.635591314521, 4911.705297682151, 5362.276092727432, 5608.887822243532, 5648.406917273709, 5069.264956581275, 5880.94119058804, 6041.879162416727, 6154.3845615438095, 6195.597286176384, 4689.742064186503, 5335.973320133375, 5445.891082178334, 5619.129034999582, 5632.718748906699, 3065.816051036945, 3189.8086114833186, 3197.9840100799347, 3206.278587317835, 3214.8874789382726, 4951.8266860659705, 5158.045761534128, 5773.566982476331, 6381.968090159519, 6411.647359395278, 5272.947270527322, 5460.836174914759, 5906.9620980761565, 6259.935810912156, 6295.670601877335, 5351.411344752152, 6061.696915154224, 6332.271788744353, 6414.550981431348, 6422.4862011039, 5586.0673146598365, 5883.499902508334, 5981.730822112929, 6012.248468941382, 6104.847378815565, 5506.779728810803, 5978.671173085522, 6043.8186854394435, 6053.757849685963, 6075.331713511422, 5964.7912323068485, 6310.242770867525, 6348.269948955929, 6355.777547785805, 6366.586171898812, 3379.7465190110347, 3989.501312335958, 4001.599840015975, 4036.253293140778, 4040.9393859092725, 5110.926705391761, 5557.221689059462, 6047.78832740852, 6131.386861313833, 6162.705831775377, 4974.0, 5345.705986170798, 5526.336839579116, 5928.9407105928385, 5952.910706339495, 5877.794277200277, 5938.2280303560265, 5943.613665111754, 5966.49284810796, 5994.310654274815, 5729.3124825019595, 5775.653460792366, 5806.883862322646, 5807.796727114531, 5838.824835254949, 5286.762095705625, 5542.972285138549, 5886.381929897299, 5922.230110085661, 5944.0, 4699.436067671902, 5235.89528209426, 5246.563500906912, 5762.222100016612, 5768.942310577008], "value": 4242.411673188663, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [719.2699410098751, 774.7482068327795, 785.2187073861508, 797.8484088023275, 845.337187858246, 15467.071975681452, 16331.265093070811, 16786.244618992143, 16848.91575542122, 16874.325026998937, 14854.405823767063, 14939.477118300862, 15040.849591504082, 15120.092794432341, 15188.620284492894, 580.9883802323951, 726.0053726394847, 863.18429084515, 869.695606537713, 890.955452227386, 878.3105262369041, 906.5648488725383, 908.1327332397577, 908.6365453818493, 909.0228004894732, 922.3174850610567, 932.5570354081825, 965.7489052846275, 968.7142293023539, 972.5040229482979, 917.1653795046476, 918.7106061590578, 919.0212423768698, 949.0319873728758, 963.3160456076195, 713.20477667401, 722.5303552690741, 723.2586598736285, 723.3309189000154, 726.0996364508024, 14497.985141040132, 14499.347529361205, 14513.984021118526, 14520.346584403727, 14521.12873227599, 15011.549653510412, 15012.249387530579, 15016.0, 15118.319675614624, 15141.545753627299, 11948.103892208119, 11952.820707689392, 12114.454849531792, 12328.568500102543, 12441.3779311035, 3114.672959339282, 3843.8654647087496, 3847.3459511883048, 3950.111224974358, 3966.147278335172, 122282.38858805738, 126803.0, 126811.0, 128182.0, 129574.0, 11373.260738052, 11711.355875426932, 11733.4719937603, 11776.646700598996, 11808.822867656992, 23760.287191384286, 23988.280351589132, 24042.038318467065, 24115.517689646458, 24277.150299739424, 8175.795605109801, 8333.916660833314, 8336.0, 8346.040205376337, 8445.1977062179, 4428.158649856517, 4488.483824360175, 4488.663350248745, 4489.326601009875, 4614.377059097046, 3563.6080031196548, 3670.5778835434267, 3673.173535954389, 3699.7780133192095, 3705.981470092632, 702.3468174597571, 735.5513136986434, 738.4867517075688, 740.6852087862637, 746.7983644415978, 544.4038777538589, 598.9847208980735, 619.8481372063874, 672.7140965089817, 676.9323067693191, 8888.24449921751, 9400.576974036048, 9470.289728270407, 9574.521273936276, 9624.51877406127, 612.4457366083701, 661.4014317043084, 672.7040102354948, 672.9629870357178, 693.2616763147232, 4446.888827779331, 4546.249868771615, 4598.862034138914, 4620.930686039712, 4628.699134556243, 117993.410032951, 140769.0, 177380.0, 178721.1063944672, 184391.0, 147616.0, 147781.0, 147949.52050479356, 149849.50150498573, 152289.0, 127555.0, 127647.0, 130162.34918825346, 131105.0, 131486.34256828847, 8739.694110706349, 8998.865017024618, 9022.639094436148, 9023.503707295898, 9063.728088157366, 58870.41129588649, 68098.9785153233, 68506.65746671235, 69886.0, 70946.64526677334, 86216.56891715502, 86627.56686216529, 88876.0, 95787.52106239424, 97510.0, 13302.733945321233, 13947.16317020982, 14017.369218385402, 14110.576682699535, 14293.213873237071, 15088.849111508744, 15103.244837758288, 15220.777411184003, 15317.234138293265, 15784.0, 14406.495772647908, 14495.492657756928, 14618.634534136307, 14741.778873317124, 15478.5356439307, 13781.0, 14273.857261427253, 14442.638934026734, 14461.13233206011, 15062.698746025237, 11751.236169649288, 11900.464479098287, 12607.810882836948, 14211.928940355232, 14231.71536569242, 10833.404162771123, 11187.72030699239, 11413.771724565628, 11915.582954596548, 11959.76080478403, 11825.940870295593, 11897.821532676844, 11969.760604788029, 12052.09609279325, 12089.697757556132], "value": 8193.209383193725, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1572.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 116.0, 116.0, 116.0, 117.0, 151.0, 98.0, 168.0, 168.0, 167.0], "value": 132.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 109.0, 109.0, 142.0, 109.0, 108.0, 104.0, 110.0, 133.0, 136.0], "value": 119.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 236.0, 255.0, 195.0, 197.0, 194.0, 197.0, 185.0, 200.0, 271.0], "value": 212.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 61.0, 61.0, 82.0, 59.0, 59.0, 59.0, 59.0, 75.0, 59.0], "value": 65.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 67.0, 84.0, 80.0, 94.0, 67.0, 81.0, 75.0, 99.0, 117.0], "value": 84.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 101.0, 88.0, 111.0, 133.0, 106.0, 89.0, 85.0, 87.0, 97.0], "value": 98.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 132.0, 103.0, 106.0, 149.0, 148.0, 117.0, 96.0, 96.0, 94.0], "value": 119.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 91.0, 89.0, 91.0, 123.0, 140.0, 83.0, 131.0, 143.0, 135.0], "value": 111.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 56.0, 55.0, 59.0, 59.0, 64.0, 69.0, 77.0, 85.0], "value": 63.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 89.0, 61.0, 86.0, 106.0, 102.0, 94.0, 73.0, 63.0, 83.0], "value": 81.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 85.0, 76.0, 100.0, 96.0, 99.0, 71.0, 94.0, 76.0, 91.0], "value": 86.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 158.0, 151.0, 137.0, 156.0, 154.0, 141.0, 173.0, 193.0, 169.0], "value": 156.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 216.0, 163.0, 160.0, 166.0, 204.0, 163.0, 163.0, 159.0, 146.0], "value": 170.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 74.0, 80.0, 79.0, 67.0, 66.0, 66.0, 67.0, 67.0], "value": 70.0, "unit": "score"}]}]} 15:08:17 INFO - Return code: 0 15:08:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:08:17 ERROR - # TBPL SUCCESS # 15:08:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:08:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:08:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:08:17 INFO - 2017-01-09 15:08:17.902 screenresolution[1663:10541] starting screenresolution argv=screenresolution get 15:08:17 INFO - 2017-01-09 15:08:17.904 screenresolution[1663:10541] Display 0: 1600x1200x32@60 15:08:17 INFO - 2017-01-09 15:08:17.910 screenresolution[1664:10544] starting screenresolution argv=screenresolution list 15:08:17 INFO - Available Modes on Display 0 15:08:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:08:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:08:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:08:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:08:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:08:18 INFO - Intel Iris: 15:08:18 INFO - Chipset Model: Intel Iris 15:08:18 INFO - Type: GPU 15:08:18 INFO - Bus: Built-In 15:08:18 INFO - VRAM (Dynamic, Max): 1536 MB 15:08:18 INFO - Vendor: Intel (0x8086) 15:08:18 INFO - Device ID: 0x0a2e 15:08:18 INFO - Revision ID: 0x0009 15:08:18 INFO - Displays: 15:08:18 INFO - Display: 15:08:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:08:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:08:18 INFO - Display Serial Number: 1600x1200 60 15:08:18 INFO - Main Display: Yes 15:08:18 INFO - Mirror: Off 15:08:18 INFO - Online: Yes 15:08:18 INFO - Rotation: Supported 15:08:18 INFO - Return code: 0 15:08:18 INFO - Running post-action listener: _resource_record_post_action 15:08:18 INFO - [mozharness: 2017-01-09 23:08:18.149393Z] Finished run-tests step (success) 15:08:18 INFO - Running post-run listener: _resource_record_post_run 15:08:18 INFO - Total resource usage - Wall time: 1194s; CPU: 54.0%; Read bytes: 38413312; Write bytes: 497222656; Read time: 377; Write time: 1674 15:08:18 INFO - TinderboxPrint: CPU usage
54.3% 15:08:18 INFO - TinderboxPrint: I/O read bytes / time
38,413,312 / 377 15:08:18 INFO - TinderboxPrint: I/O write bytes / time
497,222,656 / 1,674 15:08:18 INFO - TinderboxPrint: CPU idle
2,184.6 (45.7%) 15:08:18 INFO - TinderboxPrint: CPU system
966.8 (20.2%) 15:08:18 INFO - TinderboxPrint: CPU user
1,626.3 (34.0%) 15:08:18 INFO - TinderboxPrint: Swap in / out
233,996,288 / 0 15:08:18 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 194806272; Write bytes: 186081280; Read time: 17795; Write time: 469 15:08:18 INFO - run-tests - Wall time: 1172s; CPU: 54.0%; Read bytes: 36353024; Write bytes: 299774976; Read time: 354; Write time: 1167 15:08:18 INFO - Running post-run listener: _upload_blobber_files 15:08:18 INFO - Blob upload gear active. 15:08:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:08:18 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 15:08:18 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'] 15:08:18 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 15:08:19 INFO - (blobuploader) - INFO - Open directory for files ... 15:08:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:08:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:08:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:08:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:08:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:08:19 INFO - (blobuploader) - INFO - Done attempting. 15:08:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:08:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:08:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:08:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:08:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:08:20 INFO - (blobuploader) - INFO - Done attempting. 15:08:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:08:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:08:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:08:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:08:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:08:22 INFO - (blobuploader) - INFO - Done attempting. 15:08:22 INFO - (blobuploader) - INFO - Iteration through files over. 15:08:23 INFO - Return code: 0 15:08:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:08:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:08:23 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/28b6e23d6f3c68caa10bc2eb1c6430a9170cb61d5962fb4b5d1a4a0df7f759e4cfc578d1310386e1d13815b4b86bd0b59b49048d3c2899e883b9197fe9e1f100", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c391e2795f2c079431e6f5f6a9c25e96dcf1b44aeb31c2388aa8946b17ec3924b349a41be0a4da8d39c6fa6505253078cd26de97379c01f0d969d6c917ac2b4f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c334cca4cd8f57c1f1128935371dcf28ac46c6da283ecc9766b6ca871d1b9d21d70ab9714ba155fb5a3d5df7475dba5953629c447e1e1e4e2a171a4bbaf1e637"} 15:08:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:08:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:08:23 INFO - Contents: 15:08:23 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/28b6e23d6f3c68caa10bc2eb1c6430a9170cb61d5962fb4b5d1a4a0df7f759e4cfc578d1310386e1d13815b4b86bd0b59b49048d3c2899e883b9197fe9e1f100", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c391e2795f2c079431e6f5f6a9c25e96dcf1b44aeb31c2388aa8946b17ec3924b349a41be0a4da8d39c6fa6505253078cd26de97379c01f0d969d6c917ac2b4f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c334cca4cd8f57c1f1128935371dcf28ac46c6da283ecc9766b6ca871d1b9d21d70ab9714ba155fb5a3d5df7475dba5953629c447e1e1e4e2a171a4bbaf1e637"} 15:08:23 INFO - Running post-run listener: copy_logs_to_upload_dir 15:08:23 INFO - Copying logs to upload dir... 15:08:23 INFO - mkdir: /builds/slave/test/build/upload/logs 15:08:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.871866 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-01-09 15:08:23.080855) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-09 15:08:23.088906) ========= 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.HI4IAtojgd/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.WtoISBGXPa/Listeners TMPDIR=/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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/28b6e23d6f3c68caa10bc2eb1c6430a9170cb61d5962fb4b5d1a4a0df7f759e4cfc578d1310386e1d13815b4b86bd0b59b49048d3c2899e883b9197fe9e1f100", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c391e2795f2c079431e6f5f6a9c25e96dcf1b44aeb31c2388aa8946b17ec3924b349a41be0a4da8d39c6fa6505253078cd26de97379c01f0d969d6c917ac2b4f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c334cca4cd8f57c1f1128935371dcf28ac46c6da283ecc9766b6ca871d1b9d21d70ab9714ba155fb5a3d5df7475dba5953629c447e1e1e4e2a171a4bbaf1e637"} build_url:https://queue.taskcluster.net/v1/task/OT6Np3fyRkSkOrV8JvuH8g/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010981 build_url: 'https://queue.taskcluster.net/v1/task/OT6Np3fyRkSkOrV8JvuH8g/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/28b6e23d6f3c68caa10bc2eb1c6430a9170cb61d5962fb4b5d1a4a0df7f759e4cfc578d1310386e1d13815b4b86bd0b59b49048d3c2899e883b9197fe9e1f100", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c391e2795f2c079431e6f5f6a9c25e96dcf1b44aeb31c2388aa8946b17ec3924b349a41be0a4da8d39c6fa6505253078cd26de97379c01f0d969d6c917ac2b4f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c334cca4cd8f57c1f1128935371dcf28ac46c6da283ecc9766b6ca871d1b9d21d70ab9714ba155fb5a3d5df7475dba5953629c447e1e1e4e2a171a4bbaf1e637"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-09 15:08:23.128606) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 15:08:23.128970) ========= 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.HI4IAtojgd/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.WtoISBGXPa/Listeners TMPDIR=/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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.004812 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 15:08:23.181127) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-09 15:08:23.184465) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-09 15:08:23.185088) ========= ========= Total master_lag: 0.20 =========