builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0274 starttime: 1481733545.4 results: success (0) buildid: 20161214061801 builduid: f729bcc1885a4b09b0001a7b48cac5ea revision: f51416ce7c801f9561098e079681e09b9b3c970e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-14 08:39:05.397796) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-14 08:39:05.398272) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-14 08:39:05.398585) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-14 08:39:05.425277) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 08:39:05.425635) ========= 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.eD1gXVJ0a6/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.tZlBNLvpfB/Listeners TMPDIR=/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-12-14 08:39:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 19.6M=0.001s 2016-12-14 08:39:05 (19.6 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.116321 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 08:39:05.568843) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 08:39:05.569366) ========= 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.eD1gXVJ0a6/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.tZlBNLvpfB/Listeners TMPDIR=/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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.026992 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 08:39:05.618849) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-12-14 08:39:05.619217) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev f51416ce7c801f9561098e079681e09b9b3c970e --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 f51416ce7c801f9561098e079681e09b9b3c970e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.eD1gXVJ0a6/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.tZlBNLvpfB/Listeners TMPDIR=/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-12-14 08:39:05,716 truncating revision to first 12 chars 2016-12-14 08:39:05,716 Setting DEBUG logging. 2016-12-14 08:39:05,716 attempt 1/10 2016-12-14 08:39:05,716 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/f51416ce7c80?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-14 08:39:06,414 unpacking tar archive at: mozilla-beta-f51416ce7c80/testing/mozharness/ program finished with exit code 0 elapsedTime=0.982951 ========= master_lag: 2.55 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-12-14 08:39:09.154730) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-14 08:39:09.155248) ========= script_repo_revision: f51416ce7c801f9561098e079681e09b9b3c970e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-14 08:39:09.155842) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-14 08:39:09.156291) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-14 08:39:09.178531) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-12-14 08:39:09.179146) ========= /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.eD1gXVJ0a6/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.tZlBNLvpfB/Listeners TMPDIR=/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 08:39:09 INFO - MultiFileLogger online at 20161214 08:39:09 in /builds/slave/test 08:39:09 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 08:39:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:39:09 INFO - {'append_to_log': False, 08:39:09 INFO - 'base_work_dir': '/builds/slave/test', 08:39:09 INFO - 'blob_upload_branch': 'Mozilla-Beta', 08:39:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:39:09 INFO - 'branch': 'Mozilla-Beta', 08:39:09 INFO - 'buildbot_json_path': 'buildprops.json', 08:39:09 INFO - 'config_files': ('talos/mac_config.py',), 08:39:09 INFO - 'default_actions': ('clobber', 08:39:09 INFO - 'read-buildbot-config', 08:39:09 INFO - 'download-and-extract', 08:39:09 INFO - 'populate-webroot', 08:39:09 INFO - 'create-virtualenv', 08:39:09 INFO - 'install', 08:39:09 INFO - 'run-tests'), 08:39:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:39:09 INFO - 'download_minidump_stackwalk': True, 08:39:09 INFO - 'download_symbols': 'ondemand', 08:39:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:39:09 INFO - 'tooltool.py': '/tools/tooltool.py', 08:39:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:39:09 INFO - '/tools/misc-python/virtualenv.py')}, 08:39:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:39:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:39:09 INFO - 'installer_path': 'installer.exe', 08:39:09 INFO - 'log_level': 'info', 08:39:09 INFO - 'log_name': 'talos', 08:39:09 INFO - 'log_to_console': True, 08:39:09 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:39:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:39:09 INFO - 'opt_config_files': (), 08:39:09 INFO - 'pip_index': False, 08:39:09 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:39:09 INFO - 'cmd': ('bash', 08:39:09 INFO - '-c', 08:39:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:39:09 INFO - 'enabled': True, 08:39:09 INFO - 'halt_on_failure': False, 08:39:09 INFO - 'name': 'check_screen_resolution'},), 08:39:09 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:39:09 INFO - 'cmd': ('bash', 08:39:09 INFO - '-c', 08:39:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:39:09 INFO - 'enabled': True, 08:39:09 INFO - 'halt_on_failure': False, 08:39:09 INFO - 'name': 'check_screen_resolution'},), 08:39:09 INFO - 'run_cmd_checks_enabled': True, 08:39:09 INFO - 'sps_profile': False, 08:39:09 INFO - 'sps_profile_interval': 0, 08:39:09 INFO - 'suite': 'dromaeojs-e10s', 08:39:09 INFO - 'system_bits': '32', 08:39:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:39:09 INFO - 'title': 't-yosemite-r7-0274', 08:39:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:39:09 INFO - 'use_talos_json': True, 08:39:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:39:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:39:09 INFO - 'work_dir': 'build'} 08:39:09 INFO - [mozharness: 2016-12-14 16:39:09.373993Z] Running clobber step. 08:39:09 INFO - Running pre-action listener: _resource_record_pre_action 08:39:09 INFO - Running main action method: clobber 08:39:09 INFO - rmtree: /builds/slave/test/build 08:39:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:39:11 INFO - Running post-action listener: _resource_record_post_action 08:39:11 INFO - [mozharness: 2016-12-14 16:39:11.454485Z] Finished clobber step (success) 08:39:11 INFO - [mozharness: 2016-12-14 16:39:11.454676Z] Running read-buildbot-config step. 08:39:11 INFO - Running pre-action listener: _resource_record_pre_action 08:39:11 INFO - Running main action method: read_buildbot_config 08:39:11 INFO - Using buildbot properties: 08:39:11 INFO - { 08:39:11 INFO - "project": "", 08:39:11 INFO - "product": "firefox", 08:39:11 INFO - "script_repo_revision": "production", 08:39:11 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 08:39:11 INFO - "repository": "", 08:39:11 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 08:39:11 INFO - "buildid": "20161214061801", 08:39:11 INFO - "pgo_build": "False", 08:39:11 INFO - "basedir": "/builds/slave/test", 08:39:11 INFO - "buildnumber": 5, 08:39:11 INFO - "slavename": "t-yosemite-r7-0274", 08:39:11 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 08:39:11 INFO - "platform": "yosemite_r7", 08:39:11 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 08:39:11 INFO - "branch": "mozilla-beta", 08:39:11 INFO - "repo_path": "releases/mozilla-beta", 08:39:11 INFO - "revision": "f51416ce7c801f9561098e079681e09b9b3c970e", 08:39:11 INFO - "stage_platform": "macosx64", 08:39:11 INFO - "builduid": "f729bcc1885a4b09b0001a7b48cac5ea", 08:39:11 INFO - "slavebuilddir": "test" 08:39:11 INFO - } 08:39:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/UkCE7Au-Q--otQSh6_WDVQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 08:39:11 INFO - Running post-action listener: _resource_record_post_action 08:39:11 INFO - [mozharness: 2016-12-14 16:39:11.457876Z] Finished read-buildbot-config step (success) 08:39:11 INFO - [mozharness: 2016-12-14 16:39:11.458025Z] Running download-and-extract step. 08:39:11 INFO - Running pre-action listener: _resource_record_pre_action 08:39:11 INFO - Running main action method: download_and_extract 08:39:11 INFO - mkdir: /builds/slave/test/build/tests 08:39:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:11 INFO - trying https://queue.taskcluster.net/v1/task/UkCE7Au-Q--otQSh6_WDVQ/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 08:39:11 INFO - Downloading https://queue.taskcluster.net/v1/task/UkCE7Au-Q--otQSh6_WDVQ/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 08:39:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UkCE7Au-Q--otQSh6_WDVQ/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 08:39:12 INFO - Downloaded 1165 bytes. 08:39:12 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 08:39:12 INFO - Using the following test package requirements: 08:39:12 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 08:39:12 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 08:39:12 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 08:39:12 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 08:39:12 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 08:39:12 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 08:39:12 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 08:39:12 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 08:39:12 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 08:39:12 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 08:39:12 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 08:39:12 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 08:39:12 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 08:39:12 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 08:39:12 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 08:39:12 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 08:39:12 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 08:39:12 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 08:39:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UkCE7Au-Q--otQSh6_WDVQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 08:39:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UkCE7Au-Q--otQSh6_WDVQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 08:39:12 INFO - Fetch https://queue.taskcluster.net/v1/task/UkCE7Au-Q--otQSh6_WDVQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 08:39:12 INFO - Expected file size: 16232523 08:39:19 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 08:39:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UkCE7Au-Q--otQSh6_WDVQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 08:39:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UkCE7Au-Q--otQSh6_WDVQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 08:39:19 INFO - Fetch https://queue.taskcluster.net/v1/task/UkCE7Au-Q--otQSh6_WDVQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 08:39:20 INFO - Expected file size: 16232523 08:39:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UkCE7Au-Q--otQSh6_WDVQ/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 08:39:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UkCE7Au-Q--otQSh6_WDVQ/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 08:39:27 INFO - Fetch https://queue.taskcluster.net/v1/task/UkCE7Au-Q--otQSh6_WDVQ/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 08:39:27 INFO - Expected file size: 14414089 08:39:28 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')]} 08:39:28 INFO - trying https://queue.taskcluster.net/v1/task/UkCE7Au-Q--otQSh6_WDVQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg 08:39:28 INFO - Downloading https://queue.taskcluster.net/v1/task/UkCE7Au-Q--otQSh6_WDVQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 08:39:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UkCE7Au-Q--otQSh6_WDVQ/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 08:39:30 INFO - Downloaded 86043428 bytes. 08:39:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UkCE7Au-Q--otQSh6_WDVQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg 08:39:30 INFO - mkdir: /builds/slave/test/properties 08:39:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:39:30 INFO - Writing to file /builds/slave/test/properties/build_url 08:39:30 INFO - Contents: 08:39:30 INFO - build_url:https://queue.taskcluster.net/v1/task/UkCE7Au-Q--otQSh6_WDVQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg 08:39:31 INFO - Running post-action listener: _resource_record_post_action 08:39:31 INFO - Running post-action listener: set_extra_try_arguments 08:39:31 INFO - [mozharness: 2016-12-14 16:39:31.554289Z] Finished download-and-extract step (success) 08:39:31 INFO - [mozharness: 2016-12-14 16:39:31.554418Z] Running populate-webroot step. 08:39:31 INFO - Running pre-action listener: _resource_record_pre_action 08:39:31 INFO - Running main action method: populate_webroot 08:39:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:39:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:39:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:39:31 INFO - '--tppagecycles', 08:39:31 INFO - '7'], 08:39:31 INFO - 'tests': ['tsvgm']}}, 08:39:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:39:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:39:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:39:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:39:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:39:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:39:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:39:31 INFO - 'talos_options': ['--disable-e10s'], 08:39:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:39:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:39:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:39:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:39:31 INFO - 'talos_options': ['--disable-e10s'], 08:39:31 INFO - 'tests': ['damp', 'tps']}, 08:39:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:39:31 INFO - 'tests': ['damp', 'tps']}, 08:39:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:39:31 INFO - 'tests': ['dromaeo_dom']}, 08:39:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:39:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:39:31 INFO - 'tests': ['basic_compositor_video']}, 08:39:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:39:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:39:31 INFO - 'tests': ['a11yr', 08:39:31 INFO - 'ts_paint', 08:39:31 INFO - 'tpaint', 08:39:31 INFO - 'sessionrestore', 08:39:31 INFO - 'sessionrestore_no_auto_restore', 08:39:31 INFO - 'tabpaint']}, 08:39:31 INFO - 'other-e10s': {'tests': ['a11yr', 08:39:31 INFO - 'ts_paint', 08:39:31 INFO - 'tpaint', 08:39:31 INFO - 'sessionrestore', 08:39:31 INFO - 'sessionrestore_no_auto_restore', 08:39:31 INFO - 'tabpaint']}, 08:39:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:39:31 INFO - 'ts_paint', 08:39:31 INFO - 'tpaint', 08:39:31 INFO - 'sessionrestore', 08:39:31 INFO - 'sessionrestore_no_auto_restore', 08:39:31 INFO - 'tabpaint']}, 08:39:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:39:31 INFO - 'ts_paint', 08:39:31 INFO - 'tpaint', 08:39:31 INFO - 'sessionrestore', 08:39:31 INFO - 'sessionrestore_no_auto_restore', 08:39:31 INFO - 'tabpaint']}, 08:39:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:39:31 INFO - 'tests': ['a11yr', 08:39:31 INFO - 'ts_paint', 08:39:31 INFO - 'tpaint', 08:39:31 INFO - 'sessionrestore', 08:39:31 INFO - 'sessionrestore_no_auto_restore', 08:39:31 INFO - 'tabpaint']}, 08:39:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:39:31 INFO - 'tests': ['a11yr', 08:39:31 INFO - 'ts_paint', 08:39:31 INFO - 'tpaint', 08:39:31 INFO - 'sessionrestore', 08:39:31 INFO - 'sessionrestore_no_auto_restore', 08:39:31 INFO - 'tabpaint']}, 08:39:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:39:31 INFO - 'tests': ['tsvgx', 08:39:31 INFO - 'tsvgr_opacity', 08:39:31 INFO - 'tart', 08:39:31 INFO - 'tscrollx', 08:39:31 INFO - 'cart']}, 08:39:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:39:31 INFO - 'tsvgr_opacity', 08:39:31 INFO - 'tart', 08:39:31 INFO - 'tscrollx', 08:39:31 INFO - 'cart']}, 08:39:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:39:31 INFO - 'talos_options': ['--disable-e10s'], 08:39:31 INFO - 'tests': ['tp5o']}, 08:39:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:39:31 INFO - 'tests': ['tp5o']}, 08:39:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:39:31 INFO - 'talos_options': ['--disable-e10s', 08:39:31 INFO - '--xperf_path', 08:39:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:39:31 INFO - 'tests': ['tp5n']}, 08:39:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:39:31 INFO - 'talos_options': ['--xperf_path', 08:39:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:39:31 INFO - 'tests': ['tp5n']}}, 08:39:31 INFO - 'talos.zip': {'path': '', 08:39:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:39:31 INFO - Running post-action listener: _resource_record_post_action 08:39:31 INFO - [mozharness: 2016-12-14 16:39:31.573169Z] Finished populate-webroot step (success) 08:39:31 INFO - [mozharness: 2016-12-14 16:39:31.573303Z] Running create-virtualenv step. 08:39:31 INFO - Running pre-action listener: _resource_record_pre_action 08:39:31 INFO - Running main action method: create_virtualenv 08:39:31 INFO - Creating virtualenv /builds/slave/test/build/venv 08:39:31 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 08:39:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:39:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:39:31 INFO - Using real prefix '/tools/python27' 08:39:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:39:32 INFO - Installing distribute.............................................................................................................................................................................................done. 08:39:35 INFO - Installing pip.................done. 08:39:35 INFO - Return code: 0 08:39:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:39:35 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')]} 08:39:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:35 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')]} 08:39:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:35 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 0x1097d8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10974e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fff20d81e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095ecd30>, '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 0x109452db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095e4b20>, '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.eD1gXVJ0a6/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.tZlBNLvpfB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 08:39:35 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 08:39:35 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 08:39:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eD1gXVJ0a6/Render', 08:39:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:39:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:39:35 INFO - 'HOME': '/Users/cltbld', 08:39:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:39:35 INFO - 'LOGNAME': 'cltbld', 08:39:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:35 INFO - 'MOZ_NO_REMOTE': '1', 08:39:35 INFO - 'NO_EM_RESTART': '1', 08:39:35 INFO - 'PAGER': '/bin/cat', 08:39:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:39:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:35 INFO - 'PWD': '/builds/slave/test', 08:39:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:39:35 INFO - 'SHELL': '/bin/bash', 08:39:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tZlBNLvpfB/Listeners', 08:39:35 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 08:39:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:39:35 INFO - 'USER': 'cltbld', 08:39:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:39:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:39:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:35 INFO - 'XPC_FLAGS': '0x0', 08:39:35 INFO - 'XPC_SERVICE_NAME': '0', 08:39:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:39:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:35 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 08:39:35 INFO - Cleaning up... 08:39:35 INFO - Return code: 0 08:39:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:39:35 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')]} 08:39:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:35 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')]} 08:39:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:35 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 0x1097d8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10974e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fff20d81e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095ecd30>, '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 0x109452db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095e4b20>, '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.eD1gXVJ0a6/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.tZlBNLvpfB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 08:39:35 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 08:39:35 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 08:39:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eD1gXVJ0a6/Render', 08:39:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:39:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:39:35 INFO - 'HOME': '/Users/cltbld', 08:39:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:39:35 INFO - 'LOGNAME': 'cltbld', 08:39:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:35 INFO - 'MOZ_NO_REMOTE': '1', 08:39:35 INFO - 'NO_EM_RESTART': '1', 08:39:35 INFO - 'PAGER': '/bin/cat', 08:39:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:39:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:35 INFO - 'PWD': '/builds/slave/test', 08:39:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:39:35 INFO - 'SHELL': '/bin/bash', 08:39:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tZlBNLvpfB/Listeners', 08:39:35 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 08:39:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:39:35 INFO - 'USER': 'cltbld', 08:39:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:39:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:39:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:35 INFO - 'XPC_FLAGS': '0x0', 08:39:35 INFO - 'XPC_SERVICE_NAME': '0', 08:39:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:39:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:35 INFO - Downloading/unpacking psutil>=3.1.1 08:39:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:39:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:39:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:39:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:39:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:39:38 INFO - Installing collected packages: psutil 08:39:38 INFO - Running setup.py install for psutil 08:39:39 INFO - building 'psutil._psutil_osx' extension 08:39:39 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 08:39:39 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 08:39:39 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 08:39:39 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 08:39:39 INFO - building 'psutil._psutil_posix' extension 08:39:39 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 08:39:39 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:39:39 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:39:39 INFO - ^ 08:39:39 INFO - 1 warning generated. 08:39:39 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 08:39:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:39:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:39:40 INFO - Successfully installed psutil 08:39:40 INFO - Cleaning up... 08:39:40 INFO - Return code: 0 08:39:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:39:40 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')]} 08:39:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:40 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')]} 08:39:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:40 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 0x1097d8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10974e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fff20d81e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095ecd30>, '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 0x109452db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095e4b20>, '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.eD1gXVJ0a6/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.tZlBNLvpfB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 08:39:40 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 08:39:40 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 08:39:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eD1gXVJ0a6/Render', 08:39:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:39:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:39:40 INFO - 'HOME': '/Users/cltbld', 08:39:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:39:40 INFO - 'LOGNAME': 'cltbld', 08:39:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:40 INFO - 'MOZ_NO_REMOTE': '1', 08:39:40 INFO - 'NO_EM_RESTART': '1', 08:39:40 INFO - 'PAGER': '/bin/cat', 08:39:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:39:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:40 INFO - 'PWD': '/builds/slave/test', 08:39:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:39:40 INFO - 'SHELL': '/bin/bash', 08:39:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tZlBNLvpfB/Listeners', 08:39:40 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 08:39:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:39:40 INFO - 'USER': 'cltbld', 08:39:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:39:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:39:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:40 INFO - 'XPC_FLAGS': '0x0', 08:39:40 INFO - 'XPC_SERVICE_NAME': '0', 08:39:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:39:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:39:40 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 08:39:40 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 08:39:40 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 08:39:40 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 08:39:40 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 08:39:40 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 08:39:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:39:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:39:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:39:43 INFO - Installing collected packages: mozsystemmonitor 08:39:43 INFO - Running setup.py install for mozsystemmonitor 08:39:43 INFO - Successfully installed mozsystemmonitor 08:39:43 INFO - Cleaning up... 08:39:43 INFO - Return code: 0 08:39:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:39:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:43 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 0x1097d8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10974e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fff20d81e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095ecd30>, '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 0x109452db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095e4b20>, '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.eD1gXVJ0a6/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.tZlBNLvpfB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 08:39:43 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 08:39:43 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 08:39:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eD1gXVJ0a6/Render', 08:39:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:39:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:39:43 INFO - 'HOME': '/Users/cltbld', 08:39:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:39:43 INFO - 'LOGNAME': 'cltbld', 08:39:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:43 INFO - 'MOZ_NO_REMOTE': '1', 08:39:43 INFO - 'NO_EM_RESTART': '1', 08:39:43 INFO - 'PAGER': '/bin/cat', 08:39:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:39:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:43 INFO - 'PWD': '/builds/slave/test', 08:39:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:39:43 INFO - 'SHELL': '/bin/bash', 08:39:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tZlBNLvpfB/Listeners', 08:39:43 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 08:39:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:39:43 INFO - 'USER': 'cltbld', 08:39:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:39:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:39:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:43 INFO - 'XPC_FLAGS': '0x0', 08:39:43 INFO - 'XPC_SERVICE_NAME': '0', 08:39:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:39:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:43 INFO - Downloading/unpacking jsonschema==2.5.1 08:39:43 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 08:39:43 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 08:39:43 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 08:39:43 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 08:39:43 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 08:39:43 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 08:39:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:39:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:39:46 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 08:39:46 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 08:39:46 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 08:39:46 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 08:39:46 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 08:39:46 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 08:39:46 INFO - Downloading functools32-3.2.3-2.tar.gz 08:39:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:39:46 INFO - warning: no files found matching '*.txt' 08:39:46 INFO - no previously-included directories found matching 'build' 08:39:46 INFO - no previously-included directories found matching 'dist' 08:39:46 INFO - no previously-included directories found matching '.git*' 08:39:46 INFO - Installing collected packages: jsonschema, functools32 08:39:46 INFO - Running setup.py install for functools32 08:39:46 INFO - warning: no files found matching '*.txt' 08:39:46 INFO - no previously-included directories found matching 'build' 08:39:46 INFO - no previously-included directories found matching 'dist' 08:39:46 INFO - no previously-included directories found matching '.git*' 08:39:46 INFO - Successfully installed jsonschema functools32 08:39:46 INFO - Cleaning up... 08:39:46 INFO - Return code: 0 08:39:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:39: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')]} 08:39:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39: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')]} 08:39:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:46 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 0x1097d8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10974e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fff20d81e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095ecd30>, '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 0x109452db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095e4b20>, '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.eD1gXVJ0a6/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.tZlBNLvpfB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 08:39:46 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 08:39:46 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 08:39:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eD1gXVJ0a6/Render', 08:39:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:39:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:39:46 INFO - 'HOME': '/Users/cltbld', 08:39:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:39:46 INFO - 'LOGNAME': 'cltbld', 08:39:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:46 INFO - 'MOZ_NO_REMOTE': '1', 08:39:46 INFO - 'NO_EM_RESTART': '1', 08:39:46 INFO - 'PAGER': '/bin/cat', 08:39:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:39:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:46 INFO - 'PWD': '/builds/slave/test', 08:39:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:39:46 INFO - 'SHELL': '/bin/bash', 08:39:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tZlBNLvpfB/Listeners', 08:39:46 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 08:39:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:39:46 INFO - 'USER': 'cltbld', 08:39:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:39:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:39:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:46 INFO - 'XPC_FLAGS': '0x0', 08:39:46 INFO - 'XPC_SERVICE_NAME': '0', 08:39:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:39:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:39:47 INFO - Cleaning up... 08:39:47 INFO - Return code: 0 08:39:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:39: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')]} 08:39:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39: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')]} 08:39:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:47 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 0x1097d8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10974e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fff20d81e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095ecd30>, '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 0x109452db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095e4b20>, '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.eD1gXVJ0a6/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.tZlBNLvpfB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 08:39:47 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 08:39:47 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 08:39:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eD1gXVJ0a6/Render', 08:39:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:39:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:39:47 INFO - 'HOME': '/Users/cltbld', 08:39:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:39:47 INFO - 'LOGNAME': 'cltbld', 08:39:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:47 INFO - 'MOZ_NO_REMOTE': '1', 08:39:47 INFO - 'NO_EM_RESTART': '1', 08:39:47 INFO - 'PAGER': '/bin/cat', 08:39:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:39:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:47 INFO - 'PWD': '/builds/slave/test', 08:39:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:39:47 INFO - 'SHELL': '/bin/bash', 08:39:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tZlBNLvpfB/Listeners', 08:39:47 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 08:39:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:39:47 INFO - 'USER': 'cltbld', 08:39:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:39:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:39:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:47 INFO - 'XPC_FLAGS': '0x0', 08:39:47 INFO - 'XPC_SERVICE_NAME': '0', 08:39:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:39:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:47 INFO - Downloading/unpacking blobuploader==1.2.4 08:39:47 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 08:39:47 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 08:39:47 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 08:39:47 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 08:39:47 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 08:39:47 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 08:39:49 INFO - Downloading blobuploader-1.2.4.tar.gz 08:39:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:39:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:39:50 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 08:39:50 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 08:39:50 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 08:39:50 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 08:39:50 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 08:39:50 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 08:39:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:39:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:39:50 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 08:39:50 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 08:39:50 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 08:39:50 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 08:39:50 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 08:39:50 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 08:39:51 INFO - Downloading docopt-0.6.1.tar.gz 08:39:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:39:51 INFO - Installing collected packages: blobuploader, requests, docopt 08:39:51 INFO - Running setup.py install for blobuploader 08:39:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:39:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:39:51 INFO - Running setup.py install for requests 08:39:51 INFO - Running setup.py install for docopt 08:39:51 INFO - Successfully installed blobuploader requests docopt 08:39:51 INFO - Cleaning up... 08:39:52 INFO - Return code: 0 08:39:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:39:52 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')]} 08:39:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:52 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')]} 08:39:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:52 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 0x1097d8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10974e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fff20d81e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095ecd30>, '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 0x109452db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095e4b20>, '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.eD1gXVJ0a6/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.tZlBNLvpfB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 08:39:52 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 08:39:52 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 08:39:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eD1gXVJ0a6/Render', 08:39:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:39:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:39:52 INFO - 'HOME': '/Users/cltbld', 08:39:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:39:52 INFO - 'LOGNAME': 'cltbld', 08:39:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:52 INFO - 'MOZ_NO_REMOTE': '1', 08:39:52 INFO - 'NO_EM_RESTART': '1', 08:39:52 INFO - 'PAGER': '/bin/cat', 08:39:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:39:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:52 INFO - 'PWD': '/builds/slave/test', 08:39:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:39:52 INFO - 'SHELL': '/bin/bash', 08:39:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tZlBNLvpfB/Listeners', 08:39:52 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 08:39:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:39:52 INFO - 'USER': 'cltbld', 08:39:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:39:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:39:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:52 INFO - 'XPC_FLAGS': '0x0', 08:39:52 INFO - 'XPC_SERVICE_NAME': '0', 08:39:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:39:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:39:52 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-HHEWIA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:39:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:39:52 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-HT0HkH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:39:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:39:52 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-FAAbiK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:39:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:39:52 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-gicIDq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:39:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:39:52 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-0IOBQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:39:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:39:52 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-nj1_81-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:39:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:39:52 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-9gE83j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:39:53 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-AeF4pc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:39:53 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-dxDKIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:39:53 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-91HNOX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:39:53 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-Cb078x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:39:53 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-tLNNiu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:39:53 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-2aezZp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:39:53 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-t6Zc5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:39:53 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-wDJsGI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:39:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:39:53 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-8cDIxU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:39:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:39:54 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-WVc6Kh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:39:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:39:54 INFO - Running setup.py install for manifestparser 08:39:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:39:54 INFO - Running setup.py install for mozcrash 08:39:54 INFO - Running setup.py install for mozdebug 08:39:54 INFO - Running setup.py install for mozdevice 08:39:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:39:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:39:54 INFO - Running setup.py install for mozfile 08:39:54 INFO - Running setup.py install for mozhttpd 08:39:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:39:55 INFO - Running setup.py install for mozinfo 08:39:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:39:55 INFO - Running setup.py install for mozInstall 08:39:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:39:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:39:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:39:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:39:55 INFO - Running setup.py install for mozleak 08:39:55 INFO - Running setup.py install for mozlog 08:39:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:39:55 INFO - Running setup.py install for moznetwork 08:39:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:39:55 INFO - Running setup.py install for mozprocess 08:39:55 INFO - Running setup.py install for mozprofile 08:39:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:39:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:39:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:39:56 INFO - Running setup.py install for mozrunner 08:39:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:39:56 INFO - Running setup.py install for mozscreenshot 08:39:56 INFO - Running setup.py install for moztest 08:39:56 INFO - Running setup.py install for mozversion 08:39:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:39:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:39:56 INFO - Cleaning up... 08:39:56 INFO - Return code: 0 08:39:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:39:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:56 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 0x1097d8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10974e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fff20d81e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095ecd30>, '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 0x109452db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095e4b20>, '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.eD1gXVJ0a6/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.tZlBNLvpfB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 08:39:56 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 08:39:56 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 08:39:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eD1gXVJ0a6/Render', 08:39:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:39:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:39:56 INFO - 'HOME': '/Users/cltbld', 08:39:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:39:56 INFO - 'LOGNAME': 'cltbld', 08:39:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:56 INFO - 'MOZ_NO_REMOTE': '1', 08:39:56 INFO - 'NO_EM_RESTART': '1', 08:39:56 INFO - 'PAGER': '/bin/cat', 08:39:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:39:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:56 INFO - 'PWD': '/builds/slave/test', 08:39:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:39:56 INFO - 'SHELL': '/bin/bash', 08:39:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tZlBNLvpfB/Listeners', 08:39:56 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 08:39:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:39:56 INFO - 'USER': 'cltbld', 08:39:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:39:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:39:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:56 INFO - 'XPC_FLAGS': '0x0', 08:39:56 INFO - 'XPC_SERVICE_NAME': '0', 08:39:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:39:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:39:56 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-sLqPlv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:39:57 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)) 08:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:39:57 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-lhJM9H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:39:57 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)) 08:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:39:57 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-rvGJif-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:39:57 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)) 08:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:39:57 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-FtFLKb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:39:57 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)) 08:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:39:57 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-jWQnIg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:39:57 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)) 08:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:39:57 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-ubftbL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:39:57 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)) 08:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:39:57 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-hiwADt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:39:57 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)) 08:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:39:57 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-wNVjon-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:39:57 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)) 08:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:39:57 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-r3cDVn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:39:57 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)) 08:39:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:39:57 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-iNLPea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:39:58 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)) 08:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:39:58 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-yh5IMS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:39:58 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)) 08:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:39:58 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-sVGRI9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:39:58 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)) 08:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:39:58 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-05EO0K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:39:58 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)) 08:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:39:58 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-X07Rxr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:39:58 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)) 08:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:39:58 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-F5jBJR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:39:58 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)) 08:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:39:58 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-WyxPtw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:39:58 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)) 08:39:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:39:58 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-NJHiR9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:39:58 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)) 08:39:58 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)) 08:39:58 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)) 08:39:58 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)) 08:39:58 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)) 08:39:58 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)) 08:39:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:39:58 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 08:39:58 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 08:39:58 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 08:39:58 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 08:39:58 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 08:39:58 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 08:40:01 INFO - Downloading blessings-1.6.tar.gz 08:40:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:40:01 INFO - Installing collected packages: blessings 08:40:01 INFO - Running setup.py install for blessings 08:40:01 INFO - Successfully installed blessings 08:40:01 INFO - Cleaning up... 08:40:01 INFO - Return code: 0 08:40:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:40:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:40:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:40:01 INFO - Reading from file tmpfile_stdout 08:40:01 INFO - Current package versions: 08:40:01 INFO - blessings == 1.6 08:40:01 INFO - blobuploader == 1.2.4 08:40:01 INFO - docopt == 0.6.1 08:40:01 INFO - functools32 == 3.2.3-2 08:40:01 INFO - jsonschema == 2.5.1 08:40:01 INFO - manifestparser == 1.1 08:40:01 INFO - mozInstall == 1.12 08:40:01 INFO - mozcrash == 0.17 08:40:01 INFO - mozdebug == 0.1 08:40:01 INFO - mozdevice == 0.48 08:40:01 INFO - mozfile == 1.2 08:40:01 INFO - mozhttpd == 0.7 08:40:01 INFO - mozinfo == 0.9 08:40:01 INFO - mozleak == 0.1 08:40:01 INFO - mozlog == 3.4 08:40:01 INFO - moznetwork == 0.27 08:40:01 INFO - mozprocess == 0.23 08:40:01 INFO - mozprofile == 0.28 08:40:01 INFO - mozrunner == 6.12 08:40:01 INFO - mozscreenshot == 0.1 08:40:01 INFO - mozsystemmonitor == 0.3 08:40:01 INFO - moztest == 0.7 08:40:01 INFO - mozversion == 1.4 08:40:01 INFO - psutil == 3.1.1 08:40:01 INFO - requests == 1.2.3 08:40:01 INFO - wsgiref == 0.1.2 08:40:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:40:01 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')]} 08:40:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:02 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 0x1097d8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10974e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fff20d81e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095ecd30>, '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 0x109452db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095e4b20>, '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.eD1gXVJ0a6/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.tZlBNLvpfB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 08:40:02 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 08:40:02 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 08:40:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eD1gXVJ0a6/Render', 08:40:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:40:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:40:02 INFO - 'HOME': '/Users/cltbld', 08:40:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:40:02 INFO - 'LOGNAME': 'cltbld', 08:40:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:02 INFO - 'MOZ_NO_REMOTE': '1', 08:40:02 INFO - 'NO_EM_RESTART': '1', 08:40:02 INFO - 'PAGER': '/bin/cat', 08:40:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:40:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:02 INFO - 'PWD': '/builds/slave/test', 08:40:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:40:02 INFO - 'SHELL': '/bin/bash', 08:40:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tZlBNLvpfB/Listeners', 08:40:02 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 08:40:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:40:02 INFO - 'USER': 'cltbld', 08:40:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:40:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:40:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:02 INFO - 'XPC_FLAGS': '0x0', 08:40:02 INFO - 'XPC_SERVICE_NAME': '0', 08:40:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:40:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:02 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)) 08:40:02 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)) 08:40:02 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)) 08:40:02 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)) 08:40:02 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)) 08:40:02 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)) 08:40:02 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)) 08:40:02 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)) 08:40:02 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)) 08:40:02 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)) 08:40:02 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)) 08:40:02 INFO - Cleaning up... 08:40:02 INFO - Return code: 0 08:40:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:40:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1097d8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10974e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fff20d81e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095ecd30>, '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 0x109452db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095e4b20>, '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.eD1gXVJ0a6/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.tZlBNLvpfB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 08:40:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:40:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:40:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eD1gXVJ0a6/Render', 08:40:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:40:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:40:02 INFO - 'HOME': '/Users/cltbld', 08:40:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:40:02 INFO - 'LOGNAME': 'cltbld', 08:40:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:02 INFO - 'MOZ_NO_REMOTE': '1', 08:40:02 INFO - 'NO_EM_RESTART': '1', 08:40:02 INFO - 'PAGER': '/bin/cat', 08:40:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:40:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:02 INFO - 'PWD': '/builds/slave/test', 08:40:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:40:02 INFO - 'SHELL': '/bin/bash', 08:40:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tZlBNLvpfB/Listeners', 08:40:02 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 08:40:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:40:02 INFO - 'USER': 'cltbld', 08:40:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:40:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:40:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:02 INFO - 'XPC_FLAGS': '0x0', 08:40:02 INFO - 'XPC_SERVICE_NAME': '0', 08:40:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:40:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:40:02 INFO - Cleaning up... 08:40:02 INFO - Return code: 0 08:40:02 INFO - Running post-action listener: _resource_record_post_action 08:40:02 INFO - Running post-action listener: _start_resource_monitoring 08:40:02 INFO - Starting resource monitoring. 08:40:02 INFO - [mozharness: 2016-12-14 16:40:02.911151Z] Finished create-virtualenv step (success) 08:40:02 INFO - [mozharness: 2016-12-14 16:40:02.912121Z] Running install step. 08:40:02 INFO - Running pre-action listener: _resource_record_pre_action 08:40:02 INFO - Running main action method: install 08:40:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:40:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:40:03 INFO - Reading from file tmpfile_stdout 08:40:03 INFO - Detecting whether we're running mozinstall >=1.0... 08:40:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:40:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:40:03 INFO - Reading from file tmpfile_stdout 08:40:03 INFO - Output received: 08:40:03 INFO - Usage: mozinstall [options] installer 08:40:03 INFO - Options: 08:40:03 INFO - -h, --help show this help message and exit 08:40:03 INFO - -d DEST, --destination=DEST 08:40:03 INFO - Directory to install application into. [default: 08:40:03 INFO - "/builds/slave/test"] 08:40:03 INFO - --app=APP Application being installed. [default: firefox] 08:40:03 INFO - mkdir: /builds/slave/test/build/application 08:40:03 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'] 08:40:03 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 08:40:24 INFO - Reading from file tmpfile_stdout 08:40:24 INFO - Output received: 08:40:24 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 08:40:24 INFO - Running post-action listener: _resource_record_post_action 08:40:24 INFO - [mozharness: 2016-12-14 16:40:24.981706Z] Finished install step (success) 08:40:24 INFO - [mozharness: 2016-12-14 16:40:24.981838Z] Running run-tests step. 08:40:24 INFO - Running pre-action listener: _resource_record_pre_action 08:40:24 INFO - Running main action method: run_tests 08:40:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:40:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:40:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:40:24 INFO - 2016-12-14 08:40:24.996 screenresolution[1619:7585] starting screenresolution argv=screenresolution get 08:40:24 INFO - 2016-12-14 08:40:24.998 screenresolution[1619:7585] Display 0: 1600x1200x32@60 08:40:25 INFO - 2016-12-14 08:40:25.004 screenresolution[1620:7587] starting screenresolution argv=screenresolution list 08:40:25 INFO - Available Modes on Display 0 08:40:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:40:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:40:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:40:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:40:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:40:25 INFO - Intel Iris: 08:40:25 INFO - Chipset Model: Intel Iris 08:40:25 INFO - Type: GPU 08:40:25 INFO - Bus: Built-In 08:40:25 INFO - VRAM (Dynamic, Max): 1536 MB 08:40:25 INFO - Vendor: Intel (0x8086) 08:40:25 INFO - Device ID: 0x0a2e 08:40:25 INFO - Revision ID: 0x0009 08:40:25 INFO - Displays: 08:40:25 INFO - Display: 08:40:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:40:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:40:25 INFO - Display Serial Number: 1600x1200 60 08:40:25 INFO - Main Display: Yes 08:40:25 INFO - Mirror: Off 08:40:25 INFO - Online: Yes 08:40:25 INFO - Rotation: Supported 08:40:25 INFO - Return code: 0 08:40:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:40:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:40:25 INFO - Python 2.7.3 08:40:25 INFO - Return code: 0 08:40:25 INFO - grabbing minidump binary from tooltool 08:40:25 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')]} 08:40:25 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 0x1095ecd30>, '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 0x109452db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095e4b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:40:25 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 08:40:25 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 08:40:25 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 08:40:25 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:40:25 INFO - Return code: 0 08:40:25 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:40:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:40:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:40:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:40:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:40:25 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/UkCE7Au-Q--otQSh6_WDVQ/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0274', '--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 08:40:25 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/UkCE7Au-Q--otQSh6_WDVQ/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0274 --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 08:40:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eD1gXVJ0a6/Render', 08:40:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:40:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:40:25 INFO - 'HOME': '/Users/cltbld', 08:40:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:40:25 INFO - 'LOGNAME': 'cltbld', 08:40:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:40:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:40:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:25 INFO - 'MOZ_NO_REMOTE': '1', 08:40:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:40:25 INFO - 'NO_EM_RESTART': '1', 08:40:25 INFO - 'PAGER': '/bin/cat', 08:40:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:40:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:25 INFO - 'PWD': '/builds/slave/test', 08:40:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:40:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:40:25 INFO - 'SHELL': '/bin/bash', 08:40:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tZlBNLvpfB/Listeners', 08:40:25 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 08:40:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:40:25 INFO - 'USER': 'cltbld', 08:40:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:40:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:40:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:25 INFO - 'XPC_FLAGS': '0x0', 08:40:25 INFO - 'XPC_SERVICE_NAME': '0', 08:40:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:40:25 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/UkCE7Au-Q--otQSh6_WDVQ/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0274', '--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 08:40:25 INFO - mozversion application_buildid: 20161214061801 08:40:25 INFO - mozversion application_changeset: f51416ce7c801f9561098e079681e09b9b3c970e 08:40:25 INFO - mozversion application_display_name: Firefox 08:40:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:40:25 INFO - mozversion application_name: Firefox 08:40:25 INFO - mozversion application_remotingname: firefox 08:40:25 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 08:40:25 INFO - mozversion application_vendor: Mozilla 08:40:25 INFO - mozversion application_version: 51.0 08:40:25 INFO - mozversion platform_buildid: 20161214061801 08:40:25 INFO - mozversion platform_changeset: f51416ce7c801f9561098e079681e09b9b3c970e 08:40:25 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 08:40:25 INFO - mozversion platform_version: 51.0 08:40:25 INFO - using testdate: 1481733625 08:40:25 INFO - actual date: 1481733625 08:40:25 INFO - starting webserver on 'localhost:49253' 08:40:25 INFO - SUITE-START | Running 2 tests 08:40:25 INFO - TEST-START | dromaeo_css 08:40:25 INFO - operating with platform_type : mac_ 08:40:25 INFO - Initialising browser for dromaeo_css test... 08:40:25 INFO - TEST-INFO | started process 1630 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/tmp7UL1wC/profile http://localhost:49253/getInfo.html) 08:40:28 INFO - PROCESS | 1630 | __metrics Screen width/height:1600/1200 08:40:28 INFO - PROCESS | 1630 | colorDepth:24 08:40:28 INFO - PROCESS | 1630 | Browser inner width/height: 1024/689 08:40:28 INFO - PROCESS | 1630 | __metrics 08:40:28 ERROR - PROCESS | 1630 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3015: TypeError: this.tabs is undefined 08:40:29 INFO - TEST-INFO | 1630: exit 0 08:40:29 INFO - Browser initialized. 08:40:29 INFO - Running cycle 1/1 for dromaeo_css test... 08:40:29 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/tmp7UL1wC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:40:41 INFO - PROCESS | 1634 | RSS: Main: 174452736 08:40:41 INFO - PROCESS | 1634 | 08:41:30 INFO - PROCESS | 1634 | 1481733690714 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] 08:43:41 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49253/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49253/tests/dromaeo/cssquery-ext.html) 08:43:43 INFO - PROCESS | 1634 | RSS: Main: 185741312 08:43:43 INFO - PROCESS | 1634 | 08:46:45 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49253/tests/dromaeo/cssquery-ext.html (next: http://localhost:49253/tests/dromaeo/cssquery-jquery.html) 08:46:46 INFO - PROCESS | 1634 | RSS: Main: 197857280 08:46:46 INFO - PROCESS | 1634 | 08:49:47 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49253/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49253/tests/dromaeo/cssquery-mootools.html) 08:49:48 INFO - PROCESS | 1634 | RSS: Main: 200364032 08:49:48 INFO - PROCESS | 1634 | 08:52:50 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49253/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49253/tests/dromaeo/cssquery-prototype.html) 08:52:50 INFO - PROCESS | 1634 | RSS: Main: 204693504 08:52:50 INFO - PROCESS | 1634 | 08:55:53 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49253/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49253/tests/dromaeo/cssquery-yui.html) 08:55:54 INFO - PROCESS | 1634 | RSS: Main: 206782464 08:55:54 INFO - PROCESS | 1634 | 08:58:57 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49253/tests/dromaeo/cssquery-yui.html (next: http://localhost:49253/tests/dromaeo/cssquery-dojo.html) 08:58:57 INFO - PROCESS | 1634 | RSS: Main: 208203776 08:58:57 INFO - PROCESS | 1634 | 08:58:57 INFO - PROCESS | 1634 | __start_tp_report 08:58:57 INFO - PROCESS | 1634 | _x_x_mozilla_page_load 08:58:57 INFO - PROCESS | 1634 | _x_x_mozilla_page_load_details 08:58:57 INFO - PROCESS | 1634 | |i|pagename|runs| 08:58:57 INFO - PROCESS | 1634 | |0;dojo.html;2988.297750028743;3603.4414665726804;3624.420092785154;3642.198716282417;3670.541182352206;6003.759849606011;6055.5155587553;6075.696215189234;6079.300880398756;6083.604565703226;5990.071538911476;6074.210352654149;6082.969585152079;6100.450959413652;6110.1140334651445;5448.346198456181;5478.096114141162;5480.342358916935;5531.917021244684;5547.500724934755;5511.779528818843;5531.585131115163;5558.416366281543;5563.304586926634;5589.860253493654;4533.863984080483;5248.21276808478;5249.580033597322;5531.0873705838485;5551.028570000254;5426.050441172799;5463.31708536433;5506.834794956158;5528.75120619569;5590.580706447033;4428.512863585003;5349.197620356938;5416.889537644774;5479.205515200313;5494.203340515643;5856.355800861902;5955.166276721263;6005.339412664647;6121.571489995702;6124.663143527104;6231.283402408691;6238;6266.373362663743;6269.153664255313;6275.435210831047;6353.047042943549;6353.5234857385885;6358.968205158991;6446.290908000116;6483.384078512581;6181.690915454209;6195;6201.782937597162;6201.844953876099;6202.28673702521;5414.648047876875;5454.7818087276855;6453.870922581522;6461.709223084972;6579.539432239697;5218.556422704037;6263.060540918898;6304.527160462983;6313.210848643919;6323.430891219812;6259.123722678829;6348.650824204621;6405.967970160119;6430.646314452656;6443.194600674916;5711.428857114255;6064.302605200371;6249.593776404519;6347.68261586928;6363.7772677956045;6294.8111556653375;6337.746490140343;6337.9683101585115;6339.809805705836;6352.6823658816875;4310.870673879788;5061.898762024739;5109.897802043938;5197.636165468457;5209.088409528317;4541.091781643684;4552.681312308173;4594.196015697306;4638.0260145369175;4696.412948381452;6118.082287656887;6200.56596038282;6248.625082495065;6256.7810126645345;6262.718177682015;6400.807975760735;6431.74273029083;6432.260290066609;6470.352964703586;6473.126127972758;6128.778133445034;6133.478654314344;6147.678249176359;6180;6220.720067596969;5153.866149447115;5278;5699.686517241592;5717.828465146053;5750.568707346965;6661.566998145105;6698.263191048981;6714.966425167843;6725.226598941086;6737.494687898427;6266.185395898504;6287.622742635456;6319.58922670025;6322.873542529215;6427.6516300321755;6640.833979150367;6655.500837437115;6662.467002639681;6676;6685.064091027163;6330.651814150266;6347.90478142819;6368.076628888878;6368.235811702625;6380.011098279774;6221.09794079865;6273.404026617464;6282.277538083179;6378.2346118466085;6429.196350456193;5799.565032622486;6157.784477543264;6286.968565157145;6297.4017468340435;6315.96842015787;6236.095766113979;6268.592541484789;6299.590526615755;6301.464375528131;6307.873842523216;6025.909611355745;6189.35011823752;6255.906161407674;6295.401936815995;6302.054691796084;6205.81382558524;6226.875462490815;6276.372362763687;6281.340459251713;6312.747490100344;6256.593321434092;6267.4045965633195;6284.24589049317;6305.716242768995;6314.557980941474 08:58:57 INFO - PROCESS | 1634 | |1;ext.html;470.6846412903355;503.84632687030467;517.9563180191914;547.1164070026905;593.172524328562;32121.678783212163;43042.99999999996;43105.78447107764;43192.352114718306;43312.56687433125;43430.348544771856;43847.12305753883;43880.56119438804;44027;44051.77974110133;9817.558209880555;9829.606815727362;9906.851397229048;10006.54970526328;10030.197584193247;9821.066998635119;9896.158826499755;9897.208223342152;9930.900690993107;9933.900660993406;9901.702948911508;9942.801143977116;9944.602215911355;9947.253955953296;9964.75088122799;9883.308168428213;9914.454704991223;9925.1067403934;9925.801483970352;9946.254030947708;8011.758177482441;9726.416415015121;9891.357061791032;9945;9946.701598952042;39793.40309895354;40511.78464646036;40792.59207407918;40918.79540602308;40969.59030409688;3263.7062664360083;3428.674275943781;3558.430651095812;3735.3649879520276;3945.368741001426;25700.48599028028;30890.536641950388;30982.690173098206;31228.531572026437;31860.884869029473;3304.6364899861237;3434.072800343918;3502.2295095079044;3569.1434055826417;3581.8209089545417;489411;493627;495160;495190;497532;28724.994625188017;35355;53817.38547843571;58617.12074318888;61423.07865382023;36855.26289474196;37334.81332593374;37536.624633753316;37640.43539346912;37686.43470347947;12828.871711282954;15847.366105355657;16030.599235019217;16044.278007489691;16044.358225670843;13187.868121318856;13325.800112998313;13451.529196478075;13455.865441345657;13472.056956012984;8165.979252593425;8225.300849427746;8251.133630968661;8310.875336869953;8332.708355207538;3400.982995085009;3415.487676848493;3431.8627254909525;3431.879884204041;3466.930661386758;974.9025097490194;987.4124895687055;1031.2729525684374;1033.26121822897;1073.2004656530778;31418.685813141576;31482.685173148435;31561;31596.684033159832;31915.042548723577;939.2908354192678;1070.8447275145215;1105.7512059786484;1127.329239102749;1130.5647325779635;12261.509539618493;14076.577702668936;15963.281652325673;16469.176541172892;16519.504414867573;619660;631322;633591;637470;640870;61050;61620.691896541124;61737.38262617317;61773;61776.382236177065;1423.4519709911551;1433.9211343376214;1446.2118145610457;1451.506487794155;1456.0608407577054;25224.621630675923;30502.847485762428;31139.84430077835;31198.68801311958;31856.36287274288;51041;52500.212496811815;52942.47057529375;52964.470355295955;53145;551001;557688;558296;559000;561014;28034.85982570074;28054.2986425341;28208.71791282143;28573;28618;47721.52278477171;47993;48172;48390.75804620954;48589.5141048585;33925.83037084799;39344;39424.802875985435;40143.99640008906;40826.9793255171;32784.83607581947;35179.120521987155;37359.626403735616;39702.60297396989;39858.402123967586;34480.82759586186;34855.65144348524;35053.47419788654;38528.229435410576;39675.60324396835;31747;34753.30493390169;35886.820565897004;36404.27191456103;36447.27105457929;25656.743432565436;26486.735132648428;26525.469490610467;26758;26844.194674159808 08:58:57 INFO - PROCESS | 1634 | |2;jquery.html;355.9644035596442;372.39857629927656;378.4758110017625;385.17188045701744;392.75649097559517;19067.264573991015;21235;21497.03263353149;21643.67534486984;21819.563608727814;20840.89579552104;20909.268175613855;20984.265550705728;21038.36884893452;21749.565008699818;5856.824295271149;5939.435753603411;6093.268807743077;6135.895538803014;6156.2920264169525;3954.1893911748166;4436.933445998313;6098.268207815068;6109.236345456818;6156.969215153918;6536.182977127859;6794.388505034546;6867.862642747142;6868.484863635223;6876.312368763109;6535.019747037934;6786.423154031938;6804.21751498579;6822.454203663695;6862.416694580967;5311.282976798121;5913.497352725023;5923.555733320019;5941.346451890288;5947.345791962881;13504.39230234632;13543.661408464768;19990.50071244648;24826.131085411926;25474.49051018969;2211.590855691702;2348.6711860339565;2367.490989437262;2792.539231026878;2900.274931267183;10207.591696332138;10399.428031458267;10665.626703065356;10694.625688100958;11804.704882377924;1562.992185039079;1860.479065861561;1887.8300952914303;1906.066027646457;1936.1868015433552;121897;123142.38428807889;123660;125813.37093314566;127389.36305318413;9760.511974401394;11851.644450666494;11926.284422934652;11979.981701555465;12041.15711900176;15221.771673424908;15245.1615161165;15268.160251186291;15273.236338183046;15274;8745.212930836255;9077;9099.727008189633;9200.493972831424;9205.217556507638;8925.642974280956;9041.502717350477;9139.95430022859;9278.536073196448;9357.157855793012;4622.399088118523;4641.628669706415;4694.577488026094;4734.289856521549;4830.7101573905675;1482.8878341244067;1624.350259896051;1930.7007413850877;1985.3249895035758;1997.5705223377045;777.8872063550754;887.1837909123622;905.307439808547;929.0013235771572;1032.3496197395743;21536.24623138214;21664.566708666054;21692;21711.674324885138;21743.782562174176;795.3756301303449;966.9854952175723;978.5205249427871;1000.3847633705219;1013.7110923386947;11189.216754827246;11198.38408887519;11272.943635281936;11499.827502587468;11534;597366;624896.8755156286;648409;649191;649455;74582;79566.6021669888;102202.97797021935;112757;135360;970.2044323654677;985.5269470654126;1002.5989604158249;1002.8445590933417;1005.0301459092011;18943.90528047351;19270.132844021773;19401.611967760848;19445.222191112196;19456.416307510797;54753.726231368586;55399;55684;55966;56355.87288254294;73430.16424589214;81517.18482815333;86547.56726216328;91899;94275;6908.447324214151;7914.129445761077;8094.716684915999;8225.506469611842;8621.353398495263;8435.987681478262;8683.696070637498;12329.938350308192;13493.73012539724;13564.593062208149;10005.349652272578;11356.375399353115;11606.94196529012;11761.294322340687;12156.684377046022;9910;11473.024792892698;11628;11751.823722643996;11794.823077654013;10059.949700251453;11703.941480292544;11766.58816941403;11899.940500297444;11955.282683039046;7386.667599958122;7779.572123533034;8468.872966905625;8651.48091114535;8671.826563468821;11445.713857153638;11540.596079137189;11601.303921764384;11623.418829058683;12097.637070887888 08:58:57 INFO - PROCESS | 1634 | |3;mootools.html;1334.166146158651;1494.9551513454594;1673.339031082723;1683.1415977851293;1740.808511063782;8232.341412686985;8475.491470511759;8570.442921210117;9270.860937085949;9273.721788346344;8678.132186781319;8946.28429725622;8993.505357205351;9115.863262051074;9121.863172052408;2380.5833979053596;2393.3537944754908;2405.591049521581;2432.4162201071704;2435.147698305597;1954.765428148624;2433;2451.0563433078214;2460.6801115855005;2467.962980555293;2422.2854257993845;2430.720467146274;2442.1574556777973;2443.2792326263793;2447.853128812268;2409.0965887792077;2424.406020524974;2425.163318655061;2428.3079322393123;2441.9145329913545;2420.382802385398;2420.8305418620703;2425.745296743834;2427.6115821468657;2430.477447348811;9027.909720902839;9061.954690226572;9112.589933453011;9191.218746406563;9198.586063627154;5403.081476149025;5437.728113594305;5440.619156658996;5528.226048353234;5554.0835762099205;3595.7706222142438;3737.5328083989502;3746.512953316079;3758.530183727034;3786.753860999026;1116.625930313346;1118.5637601335486;1123.859517560305;1131.264677959325;1134.6369161868206;11649.76700465986;12005.459754311078;12114.575989840401;12152.392380380945;12158.392080396034;4509.368688383629;4578.748168850745;4681.087187998308;4764.213904705684;4768.904621907543;9292.256619470427;9303.674371396968;9323.580438880266;9327.673531426368;9382.296327775444;5305.893882122413;5333.359996800331;5341.385740639798;5387.488188622075;5397.433269506724;4570.360149579062;4686.484486706459;4939.234418665113;4972.279019542146;5050.267711181858;3775.320442320354;3840.135969406917;3901.0247438140464;3916.6083391660604;3920.627540383659;1042.921780866423;1161.6747310753003;1180.7048237940514;1199.964001079969;1204.7891618966821;788.909275433321;810.546094187257;890.8084761776249;918.5958178401482;919.7838507950627;5742.138679198154;5771.682557459296;5854.356020837705;5859.560532960045;5966.343702192756;445.86624012796034;451.2734497459088;454.0170530800845;454.2255454450154;455.1670443089205;3876.6317199865966;3877.8836634901;3935.940960885589;3968.980155099206;3971.642552170261;8658.78353041179;8673.6530538779;9087.318451116193;10949.56201751921;11118.888811111947;10976.341419514854;11009.2843965142;11035.062019728253;11076.94768996944;11091.72270693223;8353.749387518385;8442.451240669337;8489.151084891584;8526.74419767408;8584.957075214585;5709.771609135588;5801.5938884279385;5882.794102206402;5888.411158884077;5984.072468767348;8391.916080839357;10012.749681258027;10305.896941030494;10333;10353.171746260432;10193.541290641791;10301.690949271533;10365;10437.478126093512;10601.992810682972;6363.61818290904;6545.37818907203;6703.262641109376;6842.726290948505;6922.5154239202775;8563.143685631636;8738.650453981769;8766.386352955233;8767.079456656958;8775.254103401026;7655.196204398458;7764.06831180262;7836.882446763189;7908.3673306136525;7942.046954365282;7562.432817538596;7688;7695.884561731466;7703.884441733267;7713.19011503784;7115.75094871677;7129.750458733919;7241.637918104179;7243.348098671145;7251.637418129178;4878.512148785093;4910.361652985089;4987.750612469435;5027.245913113063;5123.846284611468;4987.326710893983;4996.2505624156665;5087.135187018142;5123.462036486116;5144.254083157846 08:58:57 INFO - PROCESS | 1634 | |4;prototype.html;304.9679783622721;311.61359913707;316.908096651971;316.9730572901303;320.3752682269575;5296.3379577552805;5375.516203541681;5498.862528436791;5515.889682206353;5562.721863906809;4657.464391594967;4877.000214955934;5363.570914326854;5375.193720941861;5389.838304850851;3893.9805300973458;3934.8392224293757;4157.625813676768;4162.41726158338;4162.438070860426;3739.9252014959684;3860.9034774130732;4185.8534951276715;4186.1418409226035;4188.727732697365;4058.715889887709;4060.8578699745517;4068.776217308062;4072.9389059164137;4093.529244136918;4064.8374065037365;4084.6936479764136;4108.609682080198;4118.640848519981;4137.751734895915;3409.6760807723226;3511.10466830959;3540.9822950885336;3556.946645800315;3566.8038257895805;4284.700070995032;5209.4009188943;5238.292830467876;5238.5809135269465;5300.496452836975;4067.430559721641;4577.22187228172;4662.044280922402;4734.644901632357;4751.311059896296;5094.439611642716;5579.349808840809;5665.739121869545;5705.948776368783;5751.741171647286;3433.1588760753525;3734.2344819311975;3869.361555343365;3885.164689591723;3913.804309784528;4759.357486739281;5979;6019.254416219291;6047.7580896764075;6054.636721796706;3782.8108594570713;3932.390479475686;3933.842646294116;3938.606139386096;3952.6837852971694;4006.639402453793;4017.3773065174946;4027.375756757707;4028.3957406389277;4028.9597104028585;3904.7852368120025;4107.199096176277;4676.438827340741;4689.320048592935;4710.222813235778;5283.067897316949;5524.756929690868;5671.092625179951;5783.566232532577;5805.8548536286935;1210.7336385995243;1269.2130878855169;1340.477213886585;1378.9034767566375;1382;761.9066639372518;767.493454320146;825.7687847402736;840.4621042532784;840.8024114333127;3820.9044773880873;3923.843046278174;4408.721470773504;4616.430413659372;4632.698874573142;4379.4087798147475;4942.0478910830025;4958.181899986462;5009.843798406981;5017.422996355393;3929.6070392961046;4056;4131;4609.700369475973;4628.629709623222;2411.421258897887;2495.9251222463354;2636.3936294651953;2636.446346267305;2673.8262012969094;4760.595349395271;5180.533751962342;5197.922031169535;5204.947950520522;5236.371635403776;4842.256807406842;5091.516305950929;5112.642115051911;5113.335266415343;5139.8458046258675;4233.449651545341;4833.975830120827;5010.298558201855;5136.200770579968;5137.922931156036;4797.682086122518;4933.432655244693;4945.8021679132435;4983.377077865267;4996.675216110941;4260.999999999876;4327.480702315742;4739.957209413923;4916.3362946001835;4925.38432695913;5300.761465734128;6305.779297724557;6325;6380.776672816429;6425.357464253537;3340.8997730068136;3811.7522361046445;3895.8636447724193;3900.0889564112813;4027.939580906347;5235.685858848481;5992.20233929828;6005.279366476051;6011.248593925759;6058.4244496772735;5456.235197713565;5509.449055094618;5844.561657875762;5847.035239185487;5925.288965324016;5091.632390938232;5445.564354851682;5699.601027928005;5922.911156332744;5927.9703601481715;4762.047560500178;5481.561475082063;5634.295713035871;5824.883502330014;5832.766689332379;5241.580673546031;5452.890942181213;5917.289925209003;5921.555883308855;5931.673757943355;5730.220842891111;5750.7987220447085;5760.3295044436645;5771.479397567565;5783.884322313446 08:58:57 INFO - PROCESS | 1634 | |5;yui.html;683.8358793889466;721.9783406497803;803.0443771911425;845.5518575155162;850.1668365002298;13803;15283.92358038211;16003.519894403158;16122.75815862763;16809.2435840387;15022.248887555634;15180.54458366248;15198.316075776589;15204.16377099259;15233.847661523381;719.4136778525511;738.2838646512874;868.4224990381389;883.7569668341225;894;859.6819176904554;860.724568138196;870.8780770692108;871.9667194374655;873.4846440600045;923.852183650616;926.3654396738223;929.665320484625;929.7210836748982;929.7768535551453;729.8649749796278;911.6854685133618;916.7524768312552;923.3075193604797;972.5477652891369;668.2281964331205;678.6538865178794;680.5644387591946;682.931706829318;688.1673175457652;14935.701285974328;15108.244587770678;15172.089674619558;15222.46721364747;15235.61910952224;11057.723556911062;12490;14368.568942931728;15184.088954662755;15219.315130819139;11998.300807116637;12248.265104093694;12260.141790074698;12367.319797411139;12550.623481295575;2949.985250073736;3805.676517496016;3888.766673999569;4006.2788698034633;4032.4556184914954;127313;127870;128530.71469285281;130851.34574327162;131034.03448948369;11127.221094523467;11159.609413670483;11207.775844483227;11282.717932051764;11285.887141128484;22275.665865012037;22412.66381004286;22555.548889022128;22623.88688056582;22660.980255888524;7994.760157195294;8032.598370081472;8333.6666533338;8470.322374210049;8490.702825401082;4584.289435137559;4640.930386044212;4650.116477869194;4740.217864052462;4814.301926220748;3556.7332450065833;3699.8705045323286;3703.4444833275224;3712.554493460748;3723.739338246351;659.5548005096637;692.6329045605837;696.1020283833899;716.8315445870217;744.3970383988986;582.8921649494857;676.6616691654173;681.5978572642165;683.6445048574813;693.9375456208966;9660.565274562661;9986.350887192455;10105.848412273821;10143.797124057477;10248.743781405525;666.9032990216489;680.9897851532231;685.5989246290876;690.0752990991995;702.3117345001824;4697.224957881911;4799.472058073679;4857.854264372075;4869.391326084239;4908.558229759267;92736.60895086579;124416.37791811164;139922;145117;145906.2704686491;121018;124170;124607;126049.36975315248;128209;101924.47113293306;107951;110549;118301.40849295871;120409.5918081651;8592.398532102943;10020.899791001997;10372.533236004549;10490.423026733602;10625.734356640836;62770.74458510896;63361;64044;65195.67402163149;65260;86489;89471;91386;92795.07204927865;94210.52894735482;13211.801822972471;13474.93262533681;13530.391132399263;13623.795643065163;13623.86376136226;14798.260086995822;14890.883193721342;15228.923855380652;15599.922000389925;15613.98509096905;13462.730745385234;14242.216678082805;14399.92800035993;14435.277126737144;14554.636134096309;14096.436142554594;14132.78800818009;14260.001799874324;14292.42830286777;14349.784753228918;13840.515581954583;13931.721365572834;13960.650983725489;14233.64415889611;14537.854621454073;11441.370724610226;11524.481398337262;12002.21985570935;12090.51637934508;12225.572104976283;9757.512124393894;10117;10568.313059651098;11700.239484433485;11982.940085299517 08:58:57 INFO - PROCESS | 1634 | __end_tp_report 08:58:57 INFO - PROCESS | 1634 | __start_cc_report 08:58:57 INFO - PROCESS | 1634 | _x_x_mozilla_cycle_collect,355 08:58:57 INFO - PROCESS | 1634 | __end_cc_report 08:58:57 INFO - PROCESS | 1634 | __startTimestamp1481734737260__endTimestamp 08:58:57 INFO - PROCESS | 1634 | 08:58:57 INFO - PROCESS | 1634 | ------- Summary: start ------- 08:58:57 INFO - PROCESS | 1634 | Number of tests: 6 08:58:57 INFO - PROCESS | 1634 | 08:58:57 INFO - PROCESS | 1634 | [#0] dojo.html Cycles:165 Average:5940.41 Median:6221.10 stddev:671.50 (10.8%) stddev-sans-first:632.37 08:58:57 INFO - PROCESS | 1634 | Values: 2988.3 3603.4 3624.4 3642.2 3670.5 6003.8 6055.5 6075.7 6079.3 6083.6 5990.1 6074.2 6083.0 6100.5 6110.1 5448.3 5478.1 5480.3 5531.9 5547.5 5511.8 5531.6 5558.4 5563.3 5589.9 4533.9 5248.2 5249.6 5531.1 5551.0 5426.1 5463.3 5506.8 5528.8 5590.6 4428.5 5349.2 5416.9 5479.2 5494.2 5856.4 5955.2 6005.3 6121.6 6124.7 6231.3 6238.0 6266.4 6269.2 6275.4 6353.0 6353.5 6359.0 6446.3 6483.4 6181.7 6195.0 6201.8 6201.8 6202.3 5414.6 5454.8 6453.9 6461.7 6579.5 5218.6 6263.1 6304.5 6313.2 6323.4 6259.1 6348.7 6406.0 6430.6 6443.2 5711.4 6064.3 6249.6 6347.7 6363.8 6294.8 6337.7 6338.0 6339.8 6352.7 4310.9 5061.9 5109.9 5197.6 5209.1 4541.1 4552.7 4594.2 4638.0 4696.4 6118.1 6200.6 6248.6 6256.8 6262.7 6400.8 6431.7 6432.3 6470.4 6473.1 6128.8 6133.5 6147.7 6180.0 6220.7 5153.9 5278.0 5699.7 5717.8 5750.6 6661.6 6698.3 6715.0 6725.2 6737.5 6266.2 6287.6 6319.6 6322.9 6427.7 6640.8 6655.5 6662.5 6676.0 6685.1 6330.7 6347.9 6368.1 6368.2 6380.0 6221.1 6273.4 6282.3 6378.2 6429.2 5799.6 6157.8 6287.0 6297.4 6316.0 6236.1 6268.6 6299.6 6301.5 6307.9 6025.9 6189.4 6255.9 6295.4 6302.1 6205.8 6226.9 6276.4 6281.3 6312.7 6256.6 6267.4 6284.2 6305.7 6314.6 08:58:57 INFO - PROCESS | 1634 | 08:58:57 INFO - PROCESS | 1634 | [#1] ext.html Cycles:180 Average:68510.45 Median:21685.09 stddev:150896.38 (695.9%) stddev-sans-first:151233.21 08:58:57 INFO - PROCESS | 1634 | Values: 470.7 503.8 518.0 547.1 593.2 32121.7 43043.0 43105.8 43192.4 43312.6 43430.3 43847.1 43880.6 44027.0 44051.8 9817.6 9829.6 9906.9 10006.5 10030.2 9821.1 9896.2 9897.2 9930.9 9933.9 9901.7 9942.8 9944.6 9947.3 9964.8 9883.3 9914.5 9925.1 9925.8 9946.3 8011.8 9726.4 9891.4 9945.0 9946.7 39793.4 40511.8 40792.6 40918.8 40969.6 3263.7 3428.7 3558.4 3735.4 3945.4 25700.5 30890.5 30982.7 31228.5 31860.9 3304.6 3434.1 3502.2 3569.1 3581.8 489411.0 493627.0 495160.0 495190.0 497532.0 28725.0 35355.0 53817.4 58617.1 61423.1 36855.3 37334.8 37536.6 37640.4 37686.4 12828.9 15847.4 16030.6 16044.3 16044.4 13187.9 13325.8 13451.5 13455.9 13472.1 8166.0 8225.3 8251.1 8310.9 8332.7 3401.0 3415.5 3431.9 3431.9 3466.9 974.9 987.4 1031.3 1033.3 1073.2 31418.7 31482.7 31561.0 31596.7 31915.0 939.3 1070.8 1105.8 1127.3 1130.6 12261.5 14076.6 15963.3 16469.2 16519.5 619660.0 631322.0 633591.0 637470.0 640870.0 61050.0 61620.7 61737.4 61773.0 61776.4 1423.5 1433.9 1446.2 1451.5 1456.1 25224.6 30502.8 31139.8 31198.7 31856.4 51041.0 52500.2 52942.5 52964.5 53145.0 551001.0 557688.0 558296.0 559000.0 561014.0 28034.9 28054.3 28208.7 28573.0 28618.0 47721.5 47993.0 48172.0 48390.8 48589.5 33925.8 39344.0 39424.8 40144.0 40827.0 32784.8 35179.1 37359.6 39702.6 39858.4 34480.8 34855.7 35053.5 38528.2 39675.6 31747.0 34753.3 35886.8 36404.3 36447.3 25656.7 26486.7 26525.5 26758.0 26844.2 08:58:57 INFO - PROCESS | 1634 | 08:58:57 INFO - PROCESS | 1634 | [#2] jquery.html Cycles:180 Average:35780.21 Median:13596.81 stddev:105262.00 (774.2%) stddev-sans-first:105523.68 08:58:57 INFO - PROCESS | 1634 | Values: 356.0 372.4 378.5 385.2 392.8 19067.3 21235.0 21497.0 21643.7 21819.6 20840.9 20909.3 20984.3 21038.4 21749.6 5856.8 5939.4 6093.3 6135.9 6156.3 3954.2 4436.9 6098.3 6109.2 6157.0 6536.2 6794.4 6867.9 6868.5 6876.3 6535.0 6786.4 6804.2 6822.5 6862.4 5311.3 5913.5 5923.6 5941.3 5947.3 13504.4 13543.7 19990.5 24826.1 25474.5 2211.6 2348.7 2367.5 2792.5 2900.3 10207.6 10399.4 10665.6 10694.6 11804.7 1563.0 1860.5 1887.8 1906.1 1936.2 121897.0 123142.4 123660.0 125813.4 127389.4 9760.5 11851.6 11926.3 11980.0 12041.2 15221.8 15245.2 15268.2 15273.2 15274.0 8745.2 9077.0 9099.7 9200.5 9205.2 8925.6 9041.5 9140.0 9278.5 9357.2 4622.4 4641.6 4694.6 4734.3 4830.7 1482.9 1624.4 1930.7 1985.3 1997.6 777.9 887.2 905.3 929.0 1032.3 21536.2 21664.6 21692.0 21711.7 21743.8 795.4 967.0 978.5 1000.4 1013.7 11189.2 11198.4 11272.9 11499.8 11534.0 597366.0 624896.9 648409.0 649191.0 649455.0 74582.0 79566.6 102203.0 112757.0 135360.0 970.2 985.5 1002.6 1002.8 1005.0 18943.9 19270.1 19401.6 19445.2 19456.4 54753.7 55399.0 55684.0 55966.0 56355.9 73430.2 81517.2 86547.6 91899.0 94275.0 6908.4 7914.1 8094.7 8225.5 8621.4 8436.0 8683.7 12329.9 13493.7 13564.6 10005.3 11356.4 11606.9 11761.3 12156.7 9910.0 11473.0 11628.0 11751.8 11794.8 10059.9 11703.9 11766.6 11899.9 11955.3 7386.7 7779.6 8468.9 8651.5 8671.8 11445.7 11540.6 11601.3 11623.4 12097.6 08:58:57 INFO - PROCESS | 1634 | 08:58:57 INFO - PROCESS | 1634 | [#3] mootools.html Cycles:180 Average:5738.69 Median:4955.76 stddev:3241.59 (65.4%) stddev-sans-first:3233.78 08:58:57 INFO - PROCESS | 1634 | Values: 1334.2 1495.0 1673.3 1683.1 1740.8 8232.3 8475.5 8570.4 9270.9 9273.7 8678.1 8946.3 8993.5 9115.9 9121.9 2380.6 2393.4 2405.6 2432.4 2435.1 1954.8 2433.0 2451.1 2460.7 2468.0 2422.3 2430.7 2442.2 2443.3 2447.9 2409.1 2424.4 2425.2 2428.3 2441.9 2420.4 2420.8 2425.7 2427.6 2430.5 9027.9 9062.0 9112.6 9191.2 9198.6 5403.1 5437.7 5440.6 5528.2 5554.1 3595.8 3737.5 3746.5 3758.5 3786.8 1116.6 1118.6 1123.9 1131.3 1134.6 11649.8 12005.5 12114.6 12152.4 12158.4 4509.4 4578.7 4681.1 4764.2 4768.9 9292.3 9303.7 9323.6 9327.7 9382.3 5305.9 5333.4 5341.4 5387.5 5397.4 4570.4 4686.5 4939.2 4972.3 5050.3 3775.3 3840.1 3901.0 3916.6 3920.6 1042.9 1161.7 1180.7 1200.0 1204.8 788.9 810.5 890.8 918.6 919.8 5742.1 5771.7 5854.4 5859.6 5966.3 445.9 451.3 454.0 454.2 455.2 3876.6 3877.9 3935.9 3969.0 3971.6 8658.8 8673.7 9087.3 10949.6 11118.9 10976.3 11009.3 11035.1 11076.9 11091.7 8353.7 8442.5 8489.2 8526.7 8585.0 5709.8 5801.6 5882.8 5888.4 5984.1 8391.9 10012.7 10305.9 10333.0 10353.2 10193.5 10301.7 10365.0 10437.5 10602.0 6363.6 6545.4 6703.3 6842.7 6922.5 8563.1 8738.7 8766.4 8767.1 8775.3 7655.2 7764.1 7836.9 7908.4 7942.0 7562.4 7688.0 7695.9 7703.9 7713.2 7115.8 7129.8 7241.6 7243.3 7251.6 4878.5 4910.4 4987.8 5027.2 5123.8 4987.3 4996.3 5087.1 5123.5 5144.3 08:58:57 INFO - PROCESS | 1634 | 08:58:57 INFO - PROCESS | 1634 | [#4] prototype.html Cycles:180 Average:4449.18 Median:4815.83 stddev:1383.77 (28.7%) stddev-sans-first:1352.24 08:58:57 INFO - PROCESS | 1634 | Values: 305.0 311.6 316.9 317.0 320.4 5296.3 5375.5 5498.9 5515.9 5562.7 4657.5 4877.0 5363.6 5375.2 5389.8 3894.0 3934.8 4157.6 4162.4 4162.4 3739.9 3860.9 4185.9 4186.1 4188.7 4058.7 4060.9 4068.8 4072.9 4093.5 4064.8 4084.7 4108.6 4118.6 4137.8 3409.7 3511.1 3541.0 3556.9 3566.8 4284.7 5209.4 5238.3 5238.6 5300.5 4067.4 4577.2 4662.0 4734.6 4751.3 5094.4 5579.3 5665.7 5705.9 5751.7 3433.2 3734.2 3869.4 3885.2 3913.8 4759.4 5979.0 6019.3 6047.8 6054.6 3782.8 3932.4 3933.8 3938.6 3952.7 4006.6 4017.4 4027.4 4028.4 4029.0 3904.8 4107.2 4676.4 4689.3 4710.2 5283.1 5524.8 5671.1 5783.6 5805.9 1210.7 1269.2 1340.5 1378.9 1382.0 761.9 767.5 825.8 840.5 840.8 3820.9 3923.8 4408.7 4616.4 4632.7 4379.4 4942.0 4958.2 5009.8 5017.4 3929.6 4056.0 4131.0 4609.7 4628.6 2411.4 2495.9 2636.4 2636.4 2673.8 4760.6 5180.5 5197.9 5204.9 5236.4 4842.3 5091.5 5112.6 5113.3 5139.8 4233.4 4834.0 5010.3 5136.2 5137.9 4797.7 4933.4 4945.8 4983.4 4996.7 4261.0 4327.5 4740.0 4916.3 4925.4 5300.8 6305.8 6325.0 6380.8 6425.4 3340.9 3811.8 3895.9 3900.1 4027.9 5235.7 5992.2 6005.3 6011.2 6058.4 5456.2 5509.4 5844.6 5847.0 5925.3 5091.6 5445.6 5699.6 5922.9 5928.0 4762.0 5481.6 5634.3 5824.9 5832.8 5241.6 5452.9 5917.3 5921.6 5931.7 5730.2 5750.8 5760.3 5771.5 5783.9 08:58:57 INFO - PROCESS | 1634 | 08:58:57 INFO - PROCESS | 1634 | [#5] yui.html Cycles:180 Average:25059.90 Median:22344.16 stddev:39224.64 (175.5%) stddev-sans-first:39291.97 08:58:57 INFO - PROCESS | 1634 | Values: 683.8 722.0 803.0 845.6 850.2 13803.0 15283.9 16003.5 16122.8 16809.2 15022.2 15180.5 15198.3 15204.2 15233.8 719.4 738.3 868.4 883.8 894.0 859.7 860.7 870.9 872.0 873.5 923.9 926.4 929.7 929.7 929.8 729.9 911.7 916.8 923.3 972.5 668.2 678.7 680.6 682.9 688.2 14935.7 15108.2 15172.1 15222.5 15235.6 11057.7 12490.0 14368.6 15184.1 15219.3 11998.3 12248.3 12260.1 12367.3 12550.6 2950.0 3805.7 3888.8 4006.3 4032.5 127313.0 127870.0 128530.7 130851.3 131034.0 11127.2 11159.6 11207.8 11282.7 11285.9 22275.7 22412.7 22555.5 22623.9 22661.0 7994.8 8032.6 8333.7 8470.3 8490.7 4584.3 4640.9 4650.1 4740.2 4814.3 3556.7 3699.9 3703.4 3712.6 3723.7 659.6 692.6 696.1 716.8 744.4 582.9 676.7 681.6 683.6 693.9 9660.6 9986.4 10105.8 10143.8 10248.7 666.9 681.0 685.6 690.1 702.3 4697.2 4799.5 4857.9 4869.4 4908.6 92736.6 124416.4 139922.0 145117.0 145906.3 121018.0 124170.0 124607.0 126049.4 128209.0 101924.5 107951.0 110549.0 118301.4 120409.6 8592.4 10020.9 10372.5 10490.4 10625.7 62770.7 63361.0 64044.0 65195.7 65260.0 86489.0 89471.0 91386.0 92795.1 94210.5 13211.8 13474.9 13530.4 13623.8 13623.9 14798.3 14890.9 15228.9 15599.9 15614.0 13462.7 14242.2 14399.9 14435.3 14554.6 14096.4 14132.8 14260.0 14292.4 14349.8 13840.5 13931.7 13960.7 14233.6 14537.9 11441.4 11524.5 12002.2 12090.5 12225.6 9757.5 10117.0 10568.3 11700.2 11982.9 08:58:57 INFO - PROCESS | 1634 | -------- Summary: end -------- 08:58:57 INFO - PROCESS | 1634 | 08:58:57 INFO - TEST-INFO | 1634: exit 0 08:58:57 INFO - TEST-OK | dromaeo_css | took 1112199ms 08:58:57 INFO - TEST-START | kraken 08:58:57 INFO - operating with platform_type : mac_ 08:58:57 INFO - Initialising browser for kraken test... 08:58:57 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/tmpCjbkeB/profile http://localhost:49253/getInfo.html) 08:59:00 INFO - PROCESS | 1645 | __metrics Screen width/height:1600/1200 08:59:00 INFO - PROCESS | 1645 | colorDepth:24 08:59:00 INFO - PROCESS | 1645 | Browser inner width/height: 1024/689 08:59:00 INFO - PROCESS | 1645 | __metrics 08:59:00 ERROR - PROCESS | 1645 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3015: TypeError: this.tabs is undefined 08:59:00 INFO - TEST-INFO | 1645: exit 0 08:59:00 INFO - Browser initialized. 08:59:00 INFO - Running cycle 1/1 for kraken test... 08:59:00 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/tmpCjbkeB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:59:12 INFO - PROCESS | 1648 | RSS: Main: 174747648 08:59:12 INFO - PROCESS | 1648 | 08:59:15 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49253/tests/kraken/driver.html?testName=audio-beat-detection) 08:59:16 INFO - PROCESS | 1648 | RSS: Main: 186683392 08:59:16 INFO - PROCESS | 1648 | 08:59:18 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49253/tests/kraken/driver.html?testName=audio-dft) 08:59:19 INFO - PROCESS | 1648 | RSS: Main: 194138112 08:59:19 INFO - PROCESS | 1648 | 08:59:22 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49253/tests/kraken/driver.html?testName=audio-fft) 08:59:23 INFO - PROCESS | 1648 | RSS: Main: 197791744 08:59:23 INFO - PROCESS | 1648 | 08:59:25 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49253/tests/kraken/driver.html?testName=audio-oscillator) 08:59:25 INFO - PROCESS | 1648 | RSS: Main: 199282688 08:59:25 INFO - PROCESS | 1648 | 08:59:27 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49253/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:59:28 INFO - PROCESS | 1648 | RSS: Main: 199319552 08:59:28 INFO - PROCESS | 1648 | 08:59:31 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49253/tests/kraken/driver.html?testName=imaging-darkroom) 08:59:32 INFO - PROCESS | 1648 | RSS: Main: 199929856 08:59:32 INFO - PROCESS | 1648 | 08:59:35 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49253/tests/kraken/driver.html?testName=imaging-desaturate) 08:59:35 INFO - PROCESS | 1648 | RSS: Main: 200155136 08:59:35 INFO - PROCESS | 1648 | 08:59:38 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49253/tests/kraken/driver.html?testName=json-parse-financial) 08:59:39 INFO - PROCESS | 1648 | RSS: Main: 200589312 08:59:39 INFO - PROCESS | 1648 | 08:59:41 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49253/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:59:41 INFO - PROCESS | 1648 | RSS: Main: 199999488 08:59:41 INFO - PROCESS | 1648 | 08:59:43 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49253/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:59:44 INFO - PROCESS | 1648 | RSS: Main: 200396800 08:59:44 INFO - PROCESS | 1648 | 08:59:46 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49253/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:59:47 INFO - PROCESS | 1648 | RSS: Main: 200073216 08:59:47 INFO - PROCESS | 1648 | 08:59:49 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49253/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:59:50 INFO - PROCESS | 1648 | RSS: Main: 200101888 08:59:50 INFO - PROCESS | 1648 | 08:59:53 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49253/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:59:54 INFO - PROCESS | 1648 | RSS: Main: 200425472 08:59:54 INFO - PROCESS | 1648 | 08:59:55 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49253/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49253/tests/kraken/driver.html?testName=ai-astar) 08:59:56 INFO - PROCESS | 1648 | RSS: Main: 201961472 08:59:56 INFO - PROCESS | 1648 | 08:59:56 INFO - PROCESS | 1648 | __start_tp_report 08:59:56 INFO - PROCESS | 1648 | _x_x_mozilla_page_load 08:59:56 INFO - PROCESS | 1648 | _x_x_mozilla_page_load_details 08:59:56 INFO - PROCESS | 1648 | |i|pagename|runs| 08:59:56 INFO - PROCESS | 1648 | |0;ai-astar;106;117;118;116;117;117;117;117;119;115 08:59:56 INFO - PROCESS | 1648 | |1;audio-beat-detection;129;106;112;146;143;149;114;110;133;110 08:59:56 INFO - PROCESS | 1648 | |2;audio-dft;199;194;196;198;193;202;194;198;195;193 08:59:56 INFO - PROCESS | 1648 | |3;audio-fft;82;58;58;84;60;91;53;59;88;84 08:59:56 INFO - PROCESS | 1648 | |4;audio-oscillator;81;71;89;74;68;67;83;72;95;72 08:59:56 INFO - PROCESS | 1648 | |5;imaging-gaussian-blur;89;118;82;132;137;132;91;87;89;85 08:59:56 INFO - PROCESS | 1648 | |6;imaging-darkroom;100;97;123;105;154;103;156;153;124;153 08:59:56 INFO - PROCESS | 1648 | |7;imaging-desaturate;107;126;90;137;85;143;148;121;92;90 08:59:56 INFO - PROCESS | 1648 | |8;json-parse-financial;54;53;54;55;57;58;89;90;59;58 08:59:56 INFO - PROCESS | 1648 | |9;json-stringify-tinderbox;66;64;67;76;70;61;65;91;103;103 08:59:56 INFO - PROCESS | 1648 | |10;stanford-crypto-aes;84;83;82;80;83;82;80;87;101;102 08:59:56 INFO - PROCESS | 1648 | |11;stanford-crypto-ccm;152;152;163;148;152;132;138;140;168;144 08:59:56 INFO - PROCESS | 1648 | |12;stanford-crypto-pbkdf2;164;173;163;162;164;164;164;165;159;165 08:59:56 INFO - PROCESS | 1648 | |13;stanford-crypto-sha256-iterative;68;66;66;65;65;68;67;65;64;67 08:59:56 INFO - PROCESS | 1648 | __end_tp_report 08:59:56 INFO - PROCESS | 1648 | __start_cc_report 08:59:56 INFO - PROCESS | 1648 | _x_x_mozilla_cycle_collect,896 08:59:56 INFO - PROCESS | 1648 | __end_cc_report 08:59:56 INFO - PROCESS | 1648 | __startTimestamp1481734796039__endTimestamp 08:59:56 INFO - PROCESS | 1648 | 08:59:56 INFO - PROCESS | 1648 | ------- Summary: start ------- 08:59:56 INFO - PROCESS | 1648 | Number of tests: 14 08:59:56 INFO - PROCESS | 1648 | 08:59:56 INFO - PROCESS | 1648 | [#0] ai-astar Cycles:10 Average:115.90 Median:117.00 stddev:3.63 (3.1%) stddev-sans-first:1.12 08:59:56 INFO - PROCESS | 1648 | Values: 106.0 117.0 118.0 116.0 117.0 117.0 117.0 117.0 119.0 115.0 08:59:56 INFO - PROCESS | 1648 | 08:59:56 INFO - PROCESS | 1648 | [#1] audio-beat-detection Cycles:10 Average:125.20 Median:131.00 stddev:16.74 (12.8%) stddev-sans-first:17.70 08:59:56 INFO - PROCESS | 1648 | Values: 129.0 106.0 112.0 146.0 143.0 149.0 114.0 110.0 133.0 110.0 08:59:56 INFO - PROCESS | 1648 | 08:59:56 INFO - PROCESS | 1648 | [#2] audio-dft Cycles:10 Average:196.20 Median:197.00 stddev:2.97 (1.5%) stddev-sans-first:2.98 08:59:56 INFO - PROCESS | 1648 | Values: 199.0 194.0 196.0 198.0 193.0 202.0 194.0 198.0 195.0 193.0 08:59:56 INFO - PROCESS | 1648 | 08:59:56 INFO - PROCESS | 1648 | [#3] audio-fft Cycles:10 Average:71.70 Median:83.00 stddev:15.17 (18.3%) stddev-sans-first:15.62 08:59:56 INFO - PROCESS | 1648 | Values: 82.0 58.0 58.0 84.0 60.0 91.0 53.0 59.0 88.0 84.0 08:59:56 INFO - PROCESS | 1648 | 08:59:56 INFO - PROCESS | 1648 | [#4] audio-oscillator Cycles:10 Average:77.20 Median:77.50 stddev:9.40 (12.1%) stddev-sans-first:9.87 08:59:56 INFO - PROCESS | 1648 | Values: 81.0 71.0 89.0 74.0 68.0 67.0 83.0 72.0 95.0 72.0 08:59:56 INFO - PROCESS | 1648 | 08:59:56 INFO - PROCESS | 1648 | [#5] imaging-gaussian-blur Cycles:10 Average:104.20 Median:86.00 stddev:22.62 (26.3%) stddev-sans-first:23.32 08:59:56 INFO - PROCESS | 1648 | Values: 89.0 118.0 82.0 132.0 137.0 132.0 91.0 87.0 89.0 85.0 08:59:56 INFO - PROCESS | 1648 | 08:59:56 INFO - PROCESS | 1648 | [#6] imaging-darkroom Cycles:10 Average:126.80 Median:153.00 stddev:25.02 (16.4%) stddev-sans-first:24.59 08:59:56 INFO - PROCESS | 1648 | Values: 100.0 97.0 123.0 105.0 154.0 103.0 156.0 153.0 124.0 153.0 08:59:56 INFO - PROCESS | 1648 | 08:59:56 INFO - PROCESS | 1648 | [#7] imaging-desaturate Cycles:10 Average:113.90 Median:116.50 stddev:24.14 (20.7%) stddev-sans-first:25.48 08:59:56 INFO - PROCESS | 1648 | Values: 107.0 126.0 90.0 137.0 85.0 143.0 148.0 121.0 92.0 90.0 08:59:56 INFO - PROCESS | 1648 | 08:59:56 INFO - PROCESS | 1648 | [#8] json-parse-financial Cycles:10 Average:62.70 Median:58.00 stddev:14.27 (24.6%) stddev-sans-first:14.78 08:59:56 INFO - PROCESS | 1648 | Values: 54.0 53.0 54.0 55.0 57.0 58.0 89.0 90.0 59.0 58.0 08:59:56 INFO - PROCESS | 1648 | 08:59:56 INFO - PROCESS | 1648 | [#9] json-stringify-tinderbox Cycles:10 Average:76.60 Median:66.50 stddev:16.28 (24.5%) stddev-sans-first:16.81 08:59:56 INFO - PROCESS | 1648 | Values: 66.0 64.0 67.0 76.0 70.0 61.0 65.0 91.0 103.0 103.0 08:59:56 INFO - PROCESS | 1648 | 08:59:56 INFO - PROCESS | 1648 | [#10] stanford-crypto-aes Cycles:10 Average:86.40 Median:82.50 stddev:8.21 (9.9%) stddev-sans-first:8.66 08:59:56 INFO - PROCESS | 1648 | Values: 84.0 83.0 82.0 80.0 83.0 82.0 80.0 87.0 101.0 102.0 08:59:56 INFO - PROCESS | 1648 | 08:59:56 INFO - PROCESS | 1648 | [#11] stanford-crypto-ccm Cycles:10 Average:148.90 Median:152.00 stddev:11.06 (7.3%) stddev-sans-first:11.67 08:59:56 INFO - PROCESS | 1648 | Values: 152.0 152.0 163.0 148.0 152.0 132.0 138.0 140.0 168.0 144.0 08:59:56 INFO - PROCESS | 1648 | 08:59:56 INFO - PROCESS | 1648 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.30 Median:164.00 stddev:3.53 (2.2%) stddev-sans-first:3.74 08:59:56 INFO - PROCESS | 1648 | Values: 164.0 173.0 163.0 162.0 164.0 164.0 164.0 165.0 159.0 165.0 08:59:56 INFO - PROCESS | 1648 | 08:59:56 INFO - PROCESS | 1648 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.50 stddev:1.37 (2.1%) stddev-sans-first:1.27 08:59:56 INFO - PROCESS | 1648 | Values: 68.0 66.0 66.0 65.0 65.0 68.0 67.0 65.0 64.0 67.0 08:59:56 INFO - PROCESS | 1648 | -------- Summary: end -------- 08:59:56 INFO - PROCESS | 1648 | 08:59:56 INFO - TEST-INFO | 1648: exit 0 08:59:56 INFO - TEST-OK | kraken | took 58978ms 08:59:56 INFO - SUITE-END | took 1171s 08:59:57 INFO - Completed test suite (00:19:31) 08:59:57 INFO - javascript benchmark 08:59:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7361.200577585148, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2988.297750028743, 3603.4414665726804, 3624.420092785154, 3642.198716282417, 3670.541182352206, 6003.759849606011, 6055.5155587553, 6075.696215189234, 6079.300880398756, 6083.604565703226, 5990.071538911476, 6074.210352654149, 6082.969585152079, 6100.450959413652, 6110.1140334651445, 5448.346198456181, 5478.096114141162, 5480.342358916935, 5531.917021244684, 5547.500724934755, 5511.779528818843, 5531.585131115163, 5558.416366281543, 5563.304586926634, 5589.860253493654, 4533.863984080483, 5248.21276808478, 5249.580033597322, 5531.0873705838485, 5551.028570000254, 5426.050441172799, 5463.31708536433, 5506.834794956158, 5528.75120619569, 5590.580706447033, 4428.512863585003, 5349.197620356938, 5416.889537644774, 5479.205515200313, 5494.203340515643, 5856.355800861902, 5955.166276721263, 6005.339412664647, 6121.571489995702, 6124.663143527104, 6231.283402408691, 6238.0, 6266.373362663743, 6269.153664255313, 6275.435210831047, 6353.047042943549, 6353.5234857385885, 6358.968205158991, 6446.290908000116, 6483.384078512581, 6181.690915454209, 6195.0, 6201.782937597162, 6201.844953876099, 6202.28673702521, 5414.648047876875, 5454.7818087276855, 6453.870922581522, 6461.709223084972, 6579.539432239697, 5218.556422704037, 6263.060540918898, 6304.527160462983, 6313.210848643919, 6323.430891219812, 6259.123722678829, 6348.650824204621, 6405.967970160119, 6430.646314452656, 6443.194600674916, 5711.428857114255, 6064.302605200371, 6249.593776404519, 6347.68261586928, 6363.7772677956045, 6294.8111556653375, 6337.746490140343, 6337.9683101585115, 6339.809805705836, 6352.6823658816875, 4310.870673879788, 5061.898762024739, 5109.897802043938, 5197.636165468457, 5209.088409528317, 4541.091781643684, 4552.681312308173, 4594.196015697306, 4638.0260145369175, 4696.412948381452, 6118.082287656887, 6200.56596038282, 6248.625082495065, 6256.7810126645345, 6262.718177682015, 6400.807975760735, 6431.74273029083, 6432.260290066609, 6470.352964703586, 6473.126127972758, 6128.778133445034, 6133.478654314344, 6147.678249176359, 6180.0, 6220.720067596969, 5153.866149447115, 5278.0, 5699.686517241592, 5717.828465146053, 5750.568707346965, 6661.566998145105, 6698.263191048981, 6714.966425167843, 6725.226598941086, 6737.494687898427, 6266.185395898504, 6287.622742635456, 6319.58922670025, 6322.873542529215, 6427.6516300321755, 6640.833979150367, 6655.500837437115, 6662.467002639681, 6676.0, 6685.064091027163, 6330.651814150266, 6347.90478142819, 6368.076628888878, 6368.235811702625, 6380.011098279774, 6221.09794079865, 6273.404026617464, 6282.277538083179, 6378.2346118466085, 6429.196350456193, 5799.565032622486, 6157.784477543264, 6286.968565157145, 6297.4017468340435, 6315.96842015787, 6236.095766113979, 6268.592541484789, 6299.590526615755, 6301.464375528131, 6307.873842523216, 6025.909611355745, 6189.35011823752, 6255.906161407674, 6295.401936815995, 6302.054691796084, 6205.81382558524, 6226.875462490815, 6276.372362763687, 6281.340459251713, 6312.747490100344, 6256.593321434092, 6267.4045965633195, 6284.24589049317, 6305.716242768995, 6314.557980941474], "value": 5898.773425729617, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [470.6846412903355, 503.84632687030467, 517.9563180191914, 547.1164070026905, 593.172524328562, 32121.678783212163, 43042.99999999996, 43105.78447107764, 43192.352114718306, 43312.56687433125, 43430.348544771856, 43847.12305753883, 43880.56119438804, 44027.0, 44051.77974110133, 9817.558209880555, 9829.606815727362, 9906.851397229048, 10006.54970526328, 10030.197584193247, 9821.066998635119, 9896.158826499755, 9897.208223342152, 9930.900690993107, 9933.900660993406, 9901.702948911508, 9942.801143977116, 9944.602215911355, 9947.253955953296, 9964.75088122799, 9883.308168428213, 9914.454704991223, 9925.1067403934, 9925.801483970352, 9946.254030947708, 8011.758177482441, 9726.416415015121, 9891.357061791032, 9945.0, 9946.701598952042, 39793.40309895354, 40511.78464646036, 40792.59207407918, 40918.79540602308, 40969.59030409688, 3263.7062664360083, 3428.674275943781, 3558.430651095812, 3735.3649879520276, 3945.368741001426, 25700.48599028028, 30890.536641950388, 30982.690173098206, 31228.531572026437, 31860.884869029473, 3304.6364899861237, 3434.072800343918, 3502.2295095079044, 3569.1434055826417, 3581.8209089545417, 489411.0, 493627.0, 495160.0, 495190.0, 497532.0, 28724.994625188017, 35355.0, 53817.38547843571, 58617.12074318888, 61423.07865382023, 36855.26289474196, 37334.81332593374, 37536.624633753316, 37640.43539346912, 37686.43470347947, 12828.871711282954, 15847.366105355657, 16030.599235019217, 16044.278007489691, 16044.358225670843, 13187.868121318856, 13325.800112998313, 13451.529196478075, 13455.865441345657, 13472.056956012984, 8165.979252593425, 8225.300849427746, 8251.133630968661, 8310.875336869953, 8332.708355207538, 3400.982995085009, 3415.487676848493, 3431.8627254909525, 3431.879884204041, 3466.930661386758, 974.9025097490194, 987.4124895687055, 1031.2729525684374, 1033.26121822897, 1073.2004656530778, 31418.685813141576, 31482.685173148435, 31561.0, 31596.684033159832, 31915.042548723577, 939.2908354192678, 1070.8447275145215, 1105.7512059786484, 1127.329239102749, 1130.5647325779635, 12261.509539618493, 14076.577702668936, 15963.281652325673, 16469.176541172892, 16519.504414867573, 619660.0, 631322.0, 633591.0, 637470.0, 640870.0, 61050.0, 61620.691896541124, 61737.38262617317, 61773.0, 61776.382236177065, 1423.4519709911551, 1433.9211343376214, 1446.2118145610457, 1451.506487794155, 1456.0608407577054, 25224.621630675923, 30502.847485762428, 31139.84430077835, 31198.68801311958, 31856.36287274288, 51041.0, 52500.212496811815, 52942.47057529375, 52964.470355295955, 53145.0, 551001.0, 557688.0, 558296.0, 559000.0, 561014.0, 28034.85982570074, 28054.2986425341, 28208.71791282143, 28573.0, 28618.0, 47721.52278477171, 47993.0, 48172.0, 48390.75804620954, 48589.5141048585, 33925.83037084799, 39344.0, 39424.802875985435, 40143.99640008906, 40826.9793255171, 32784.83607581947, 35179.120521987155, 37359.626403735616, 39702.60297396989, 39858.402123967586, 34480.82759586186, 34855.65144348524, 35053.47419788654, 38528.229435410576, 39675.60324396835, 31747.0, 34753.30493390169, 35886.820565897004, 36404.27191456103, 36447.27105457929, 25656.743432565436, 26486.735132648428, 26525.469490610467, 26758.0, 26844.194674159808], "value": 19036.075441147324, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.9644035596442, 372.39857629927656, 378.4758110017625, 385.17188045701744, 392.75649097559517, 19067.264573991015, 21235.0, 21497.03263353149, 21643.67534486984, 21819.563608727814, 20840.89579552104, 20909.268175613855, 20984.265550705728, 21038.36884893452, 21749.565008699818, 5856.824295271149, 5939.435753603411, 6093.268807743077, 6135.895538803014, 6156.2920264169525, 3954.1893911748166, 4436.933445998313, 6098.268207815068, 6109.236345456818, 6156.969215153918, 6536.182977127859, 6794.388505034546, 6867.862642747142, 6868.484863635223, 6876.312368763109, 6535.019747037934, 6786.423154031938, 6804.21751498579, 6822.454203663695, 6862.416694580967, 5311.282976798121, 5913.497352725023, 5923.555733320019, 5941.346451890288, 5947.345791962881, 13504.39230234632, 13543.661408464768, 19990.50071244648, 24826.131085411926, 25474.49051018969, 2211.590855691702, 2348.6711860339565, 2367.490989437262, 2792.539231026878, 2900.274931267183, 10207.591696332138, 10399.428031458267, 10665.626703065356, 10694.625688100958, 11804.704882377924, 1562.992185039079, 1860.479065861561, 1887.8300952914303, 1906.066027646457, 1936.1868015433552, 121897.0, 123142.38428807889, 123660.0, 125813.37093314566, 127389.36305318413, 9760.511974401394, 11851.644450666494, 11926.284422934652, 11979.981701555465, 12041.15711900176, 15221.771673424908, 15245.1615161165, 15268.160251186291, 15273.236338183046, 15274.0, 8745.212930836255, 9077.0, 9099.727008189633, 9200.493972831424, 9205.217556507638, 8925.642974280956, 9041.502717350477, 9139.95430022859, 9278.536073196448, 9357.157855793012, 4622.399088118523, 4641.628669706415, 4694.577488026094, 4734.289856521549, 4830.7101573905675, 1482.8878341244067, 1624.350259896051, 1930.7007413850877, 1985.3249895035758, 1997.5705223377045, 777.8872063550754, 887.1837909123622, 905.307439808547, 929.0013235771572, 1032.3496197395743, 21536.24623138214, 21664.566708666054, 21692.0, 21711.674324885138, 21743.782562174176, 795.3756301303449, 966.9854952175723, 978.5205249427871, 1000.3847633705219, 1013.7110923386947, 11189.216754827246, 11198.38408887519, 11272.943635281936, 11499.827502587468, 11534.0, 597366.0, 624896.8755156286, 648409.0, 649191.0, 649455.0, 74582.0, 79566.6021669888, 102202.97797021935, 112757.0, 135360.0, 970.2044323654677, 985.5269470654126, 1002.5989604158249, 1002.8445590933417, 1005.0301459092011, 18943.90528047351, 19270.132844021773, 19401.611967760848, 19445.222191112196, 19456.416307510797, 54753.726231368586, 55399.0, 55684.0, 55966.0, 56355.87288254294, 73430.16424589214, 81517.18482815333, 86547.56726216328, 91899.0, 94275.0, 6908.447324214151, 7914.129445761077, 8094.716684915999, 8225.506469611842, 8621.353398495263, 8435.987681478262, 8683.696070637498, 12329.938350308192, 13493.73012539724, 13564.593062208149, 10005.349652272578, 11356.375399353115, 11606.94196529012, 11761.294322340687, 12156.684377046022, 9910.0, 11473.024792892698, 11628.0, 11751.823722643996, 11794.823077654013, 10059.949700251453, 11703.941480292544, 11766.58816941403, 11899.940500297444, 11955.282683039046, 7386.667599958122, 7779.572123533034, 8468.872966905625, 8651.48091114535, 8671.826563468821, 11445.713857153638, 11540.596079137189, 11601.303921764384, 11623.418829058683, 12097.637070887888], "value": 9703.452919962881, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1334.166146158651, 1494.9551513454594, 1673.339031082723, 1683.1415977851293, 1740.808511063782, 8232.341412686985, 8475.491470511759, 8570.442921210117, 9270.860937085949, 9273.721788346344, 8678.132186781319, 8946.28429725622, 8993.505357205351, 9115.863262051074, 9121.863172052408, 2380.5833979053596, 2393.3537944754908, 2405.591049521581, 2432.4162201071704, 2435.147698305597, 1954.765428148624, 2433.0, 2451.0563433078214, 2460.6801115855005, 2467.962980555293, 2422.2854257993845, 2430.720467146274, 2442.1574556777973, 2443.2792326263793, 2447.853128812268, 2409.0965887792077, 2424.406020524974, 2425.163318655061, 2428.3079322393123, 2441.9145329913545, 2420.382802385398, 2420.8305418620703, 2425.745296743834, 2427.6115821468657, 2430.477447348811, 9027.909720902839, 9061.954690226572, 9112.589933453011, 9191.218746406563, 9198.586063627154, 5403.081476149025, 5437.728113594305, 5440.619156658996, 5528.226048353234, 5554.0835762099205, 3595.7706222142438, 3737.5328083989502, 3746.512953316079, 3758.530183727034, 3786.753860999026, 1116.625930313346, 1118.5637601335486, 1123.859517560305, 1131.264677959325, 1134.6369161868206, 11649.76700465986, 12005.459754311078, 12114.575989840401, 12152.392380380945, 12158.392080396034, 4509.368688383629, 4578.748168850745, 4681.087187998308, 4764.213904705684, 4768.904621907543, 9292.256619470427, 9303.674371396968, 9323.580438880266, 9327.673531426368, 9382.296327775444, 5305.893882122413, 5333.359996800331, 5341.385740639798, 5387.488188622075, 5397.433269506724, 4570.360149579062, 4686.484486706459, 4939.234418665113, 4972.279019542146, 5050.267711181858, 3775.320442320354, 3840.135969406917, 3901.0247438140464, 3916.6083391660604, 3920.627540383659, 1042.921780866423, 1161.6747310753003, 1180.7048237940514, 1199.964001079969, 1204.7891618966821, 788.909275433321, 810.546094187257, 890.8084761776249, 918.5958178401482, 919.7838507950627, 5742.138679198154, 5771.682557459296, 5854.356020837705, 5859.560532960045, 5966.343702192756, 445.86624012796034, 451.2734497459088, 454.0170530800845, 454.2255454450154, 455.1670443089205, 3876.6317199865966, 3877.8836634901, 3935.940960885589, 3968.980155099206, 3971.642552170261, 8658.78353041179, 8673.6530538779, 9087.318451116193, 10949.56201751921, 11118.888811111947, 10976.341419514854, 11009.2843965142, 11035.062019728253, 11076.94768996944, 11091.72270693223, 8353.749387518385, 8442.451240669337, 8489.151084891584, 8526.74419767408, 8584.957075214585, 5709.771609135588, 5801.5938884279385, 5882.794102206402, 5888.411158884077, 5984.072468767348, 8391.916080839357, 10012.749681258027, 10305.896941030494, 10333.0, 10353.171746260432, 10193.541290641791, 10301.690949271533, 10365.0, 10437.478126093512, 10601.992810682972, 6363.61818290904, 6545.37818907203, 6703.262641109376, 6842.726290948505, 6922.5154239202775, 8563.143685631636, 8738.650453981769, 8766.386352955233, 8767.079456656958, 8775.254103401026, 7655.196204398458, 7764.06831180262, 7836.882446763189, 7908.3673306136525, 7942.046954365282, 7562.432817538596, 7688.0, 7695.884561731466, 7703.884441733267, 7713.19011503784, 7115.75094871677, 7129.750458733919, 7241.637918104179, 7243.348098671145, 7251.637418129178, 4878.512148785093, 4910.361652985089, 4987.750612469435, 5027.245913113063, 5123.846284611468, 4987.326710893983, 4996.2505624156665, 5087.135187018142, 5123.462036486116, 5144.254083157846], "value": 4525.262934417564, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.9679783622721, 311.61359913707, 316.908096651971, 316.9730572901303, 320.3752682269575, 5296.3379577552805, 5375.516203541681, 5498.862528436791, 5515.889682206353, 5562.721863906809, 4657.464391594967, 4877.000214955934, 5363.570914326854, 5375.193720941861, 5389.838304850851, 3893.9805300973458, 3934.8392224293757, 4157.625813676768, 4162.41726158338, 4162.438070860426, 3739.9252014959684, 3860.9034774130732, 4185.8534951276715, 4186.1418409226035, 4188.727732697365, 4058.715889887709, 4060.8578699745517, 4068.776217308062, 4072.9389059164137, 4093.529244136918, 4064.8374065037365, 4084.6936479764136, 4108.609682080198, 4118.640848519981, 4137.751734895915, 3409.6760807723226, 3511.10466830959, 3540.9822950885336, 3556.946645800315, 3566.8038257895805, 4284.700070995032, 5209.4009188943, 5238.292830467876, 5238.5809135269465, 5300.496452836975, 4067.430559721641, 4577.22187228172, 4662.044280922402, 4734.644901632357, 4751.311059896296, 5094.439611642716, 5579.349808840809, 5665.739121869545, 5705.948776368783, 5751.741171647286, 3433.1588760753525, 3734.2344819311975, 3869.361555343365, 3885.164689591723, 3913.804309784528, 4759.357486739281, 5979.0, 6019.254416219291, 6047.7580896764075, 6054.636721796706, 3782.8108594570713, 3932.390479475686, 3933.842646294116, 3938.606139386096, 3952.6837852971694, 4006.639402453793, 4017.3773065174946, 4027.375756757707, 4028.3957406389277, 4028.9597104028585, 3904.7852368120025, 4107.199096176277, 4676.438827340741, 4689.320048592935, 4710.222813235778, 5283.067897316949, 5524.756929690868, 5671.092625179951, 5783.566232532577, 5805.8548536286935, 1210.7336385995243, 1269.2130878855169, 1340.477213886585, 1378.9034767566375, 1382.0, 761.9066639372518, 767.493454320146, 825.7687847402736, 840.4621042532784, 840.8024114333127, 3820.9044773880873, 3923.843046278174, 4408.721470773504, 4616.430413659372, 4632.698874573142, 4379.4087798147475, 4942.0478910830025, 4958.181899986462, 5009.843798406981, 5017.422996355393, 3929.6070392961046, 4056.0, 4131.0, 4609.700369475973, 4628.629709623222, 2411.421258897887, 2495.9251222463354, 2636.3936294651953, 2636.446346267305, 2673.8262012969094, 4760.595349395271, 5180.533751962342, 5197.922031169535, 5204.947950520522, 5236.371635403776, 4842.256807406842, 5091.516305950929, 5112.642115051911, 5113.335266415343, 5139.8458046258675, 4233.449651545341, 4833.975830120827, 5010.298558201855, 5136.200770579968, 5137.922931156036, 4797.682086122518, 4933.432655244693, 4945.8021679132435, 4983.377077865267, 4996.675216110941, 4260.999999999876, 4327.480702315742, 4739.957209413923, 4916.3362946001835, 4925.38432695913, 5300.761465734128, 6305.779297724557, 6325.0, 6380.776672816429, 6425.357464253537, 3340.8997730068136, 3811.7522361046445, 3895.8636447724193, 3900.0889564112813, 4027.939580906347, 5235.685858848481, 5992.20233929828, 6005.279366476051, 6011.248593925759, 6058.4244496772735, 5456.235197713565, 5509.449055094618, 5844.561657875762, 5847.035239185487, 5925.288965324016, 5091.632390938232, 5445.564354851682, 5699.601027928005, 5922.911156332744, 5927.9703601481715, 4762.047560500178, 5481.561475082063, 5634.295713035871, 5824.883502330014, 5832.766689332379, 5241.580673546031, 5452.890942181213, 5917.289925209003, 5921.555883308855, 5931.673757943355, 5730.220842891111, 5750.7987220447085, 5760.3295044436645, 5771.479397567565, 5783.884322313446], "value": 4008.743523622172, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [683.8358793889466, 721.9783406497803, 803.0443771911425, 845.5518575155162, 850.1668365002298, 13803.0, 15283.92358038211, 16003.519894403158, 16122.75815862763, 16809.2435840387, 15022.248887555634, 15180.54458366248, 15198.316075776589, 15204.16377099259, 15233.847661523381, 719.4136778525511, 738.2838646512874, 868.4224990381389, 883.7569668341225, 894.0, 859.6819176904554, 860.724568138196, 870.8780770692108, 871.9667194374655, 873.4846440600045, 923.852183650616, 926.3654396738223, 929.665320484625, 929.7210836748982, 929.7768535551453, 729.8649749796278, 911.6854685133618, 916.7524768312552, 923.3075193604797, 972.5477652891369, 668.2281964331205, 678.6538865178794, 680.5644387591946, 682.931706829318, 688.1673175457652, 14935.701285974328, 15108.244587770678, 15172.089674619558, 15222.46721364747, 15235.61910952224, 11057.723556911062, 12490.0, 14368.568942931728, 15184.088954662755, 15219.315130819139, 11998.300807116637, 12248.265104093694, 12260.141790074698, 12367.319797411139, 12550.623481295575, 2949.985250073736, 3805.676517496016, 3888.766673999569, 4006.2788698034633, 4032.4556184914954, 127313.0, 127870.0, 128530.71469285281, 130851.34574327162, 131034.03448948369, 11127.221094523467, 11159.609413670483, 11207.775844483227, 11282.717932051764, 11285.887141128484, 22275.665865012037, 22412.66381004286, 22555.548889022128, 22623.88688056582, 22660.980255888524, 7994.760157195294, 8032.598370081472, 8333.6666533338, 8470.322374210049, 8490.702825401082, 4584.289435137559, 4640.930386044212, 4650.116477869194, 4740.217864052462, 4814.301926220748, 3556.7332450065833, 3699.8705045323286, 3703.4444833275224, 3712.554493460748, 3723.739338246351, 659.5548005096637, 692.6329045605837, 696.1020283833899, 716.8315445870217, 744.3970383988986, 582.8921649494857, 676.6616691654173, 681.5978572642165, 683.6445048574813, 693.9375456208966, 9660.565274562661, 9986.350887192455, 10105.848412273821, 10143.797124057477, 10248.743781405525, 666.9032990216489, 680.9897851532231, 685.5989246290876, 690.0752990991995, 702.3117345001824, 4697.224957881911, 4799.472058073679, 4857.854264372075, 4869.391326084239, 4908.558229759267, 92736.60895086579, 124416.37791811164, 139922.0, 145117.0, 145906.2704686491, 121018.0, 124170.0, 124607.0, 126049.36975315248, 128209.0, 101924.47113293306, 107951.0, 110549.0, 118301.40849295871, 120409.5918081651, 8592.398532102943, 10020.899791001997, 10372.533236004549, 10490.423026733602, 10625.734356640836, 62770.74458510896, 63361.0, 64044.0, 65195.67402163149, 65260.0, 86489.0, 89471.0, 91386.0, 92795.07204927865, 94210.52894735482, 13211.801822972471, 13474.93262533681, 13530.391132399263, 13623.795643065163, 13623.86376136226, 14798.260086995822, 14890.883193721342, 15228.923855380652, 15599.922000389925, 15613.98509096905, 13462.730745385234, 14242.216678082805, 14399.92800035993, 14435.277126737144, 14554.636134096309, 14096.436142554594, 14132.78800818009, 14260.001799874324, 14292.42830286777, 14349.784753228918, 13840.515581954583, 13931.721365572834, 13960.650983725489, 14233.64415889611, 14537.854621454073, 11441.370724610226, 11524.481398337262, 12002.21985570935, 12090.51637934508, 12225.572104976283, 9757.512124393894, 10117.0, 10568.313059651098, 11700.239484433485, 11982.940085299517], "value": 8048.758966936771, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1536.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 117.0, 118.0, 116.0, 117.0, 117.0, 117.0, 117.0, 119.0, 115.0], "value": 115.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 106.0, 112.0, 146.0, 143.0, 149.0, 114.0, 110.0, 133.0, 110.0], "value": 125.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 194.0, 196.0, 198.0, 193.0, 202.0, 194.0, 198.0, 195.0, 193.0], "value": 196.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 58.0, 58.0, 84.0, 60.0, 91.0, 53.0, 59.0, 88.0, 84.0], "value": 71.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 71.0, 89.0, 74.0, 68.0, 67.0, 83.0, 72.0, 95.0, 72.0], "value": 77.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 118.0, 82.0, 132.0, 137.0, 132.0, 91.0, 87.0, 89.0, 85.0], "value": 104.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 97.0, 123.0, 105.0, 154.0, 103.0, 156.0, 153.0, 124.0, 153.0], "value": 126.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 126.0, 90.0, 137.0, 85.0, 143.0, 148.0, 121.0, 92.0, 90.0], "value": 113.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 54.0, 55.0, 57.0, 58.0, 89.0, 90.0, 59.0, 58.0], "value": 62.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 67.0, 76.0, 70.0, 61.0, 65.0, 91.0, 103.0, 103.0], "value": 76.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 82.0, 80.0, 83.0, 82.0, 80.0, 87.0, 101.0, 102.0], "value": 86.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 152.0, 163.0, 148.0, 152.0, 132.0, 138.0, 140.0, 168.0, 144.0], "value": 148.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 173.0, 163.0, 162.0, 164.0, 164.0, 164.0, 165.0, 159.0, 165.0], "value": 164.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 66.0, 65.0, 65.0, 68.0, 67.0, 65.0, 64.0, 67.0], "value": 66.1, "unit": "score"}]}]} 08:59:57 INFO - Return code: 0 08:59:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:59:57 ERROR - # TBPL SUCCESS # 08:59:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:59:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:59:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:59:57 INFO - 2016-12-14 08:59:57.395 screenresolution[1653:10581] starting screenresolution argv=screenresolution get 08:59:57 INFO - 2016-12-14 08:59:57.397 screenresolution[1653:10581] Display 0: 1600x1200x32@60 08:59:57 INFO - 2016-12-14 08:59:57.403 screenresolution[1654:10584] starting screenresolution argv=screenresolution list 08:59:57 INFO - Available Modes on Display 0 08:59:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:59:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:59:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:59:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:59:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:59:57 INFO - Intel Iris: 08:59:57 INFO - Chipset Model: Intel Iris 08:59:57 INFO - Type: GPU 08:59:57 INFO - Bus: Built-In 08:59:57 INFO - VRAM (Dynamic, Max): 1536 MB 08:59:57 INFO - Vendor: Intel (0x8086) 08:59:57 INFO - Device ID: 0x0a2e 08:59:57 INFO - Revision ID: 0x0009 08:59:57 INFO - Displays: 08:59:57 INFO - Display: 08:59:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:59:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:59:57 INFO - Display Serial Number: 1600x1200 60 08:59:57 INFO - Main Display: Yes 08:59:57 INFO - Mirror: Off 08:59:57 INFO - Online: Yes 08:59:57 INFO - Rotation: Supported 08:59:57 INFO - Return code: 0 08:59:57 INFO - Running post-action listener: _resource_record_post_action 08:59:57 INFO - [mozharness: 2016-12-14 16:59:57.638759Z] Finished run-tests step (success) 08:59:57 INFO - Running post-run listener: _resource_record_post_run 08:59:57 INFO - Total resource usage - Wall time: 1194s; CPU: 54.0%; Read bytes: 37610496; Write bytes: 494715392; Read time: 247; Write time: 1570 08:59:57 INFO - TinderboxPrint: CPU usage
54.3% 08:59:57 INFO - TinderboxPrint: I/O read bytes / time
37,610,496 / 247 08:59:57 INFO - TinderboxPrint: I/O write bytes / time
494,715,392 / 1,570 08:59:57 INFO - TinderboxPrint: CPU idle
2,181.6 (45.7%) 08:59:57 INFO - TinderboxPrint: CPU system
968.1 (20.3%) 08:59:57 INFO - TinderboxPrint: CPU user
1,628.0 (34.1%) 08:59:57 INFO - TinderboxPrint: Swap in / out
232,923,136 / 0 08:59:57 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 196342272; Write bytes: 195960832; Read time: 17784; Write time: 431 08:59:57 INFO - run-tests - Wall time: 1173s; CPU: 54.0%; Read bytes: 34333696; Write bytes: 297402880; Read time: 220; Write time: 1132 08:59:58 INFO - Running post-run listener: _upload_blobber_files 08:59:58 INFO - Blob upload gear active. 08:59:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:59:58 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:59:58 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'] 08:59:58 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 08:59:58 INFO - (blobuploader) - INFO - Open directory for files ... 08:59:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:59:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:59:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:59:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:59:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:59:59 INFO - (blobuploader) - INFO - Done attempting. 08:59:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:59:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:59:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:00:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:00:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:00:00 INFO - (blobuploader) - INFO - Done attempting. 09:00:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:00:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:00:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:00:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:00:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:00:06 INFO - (blobuploader) - INFO - Done attempting. 09:00:06 INFO - (blobuploader) - INFO - Iteration through files over. 09:00:06 INFO - Return code: 0 09:00:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:00:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:00:06 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/511f3561402c10b17194714063be0fc386f88c47efd9263f3da3a13525358d0e50abea0b50ecce52a7eece35a7026c9e3cd5c82b6780f2e5e29943f370fb2f2b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7c468e1f6c97761fbe8d0c93cc4007fd24c64fd6f4407458ce556159f242ec671ae05cdbc991b860623304f7c4ffda47624568ca4c81d232dae126cb8ee72d07", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fd8ef4cfe7f33dd2be03beb840611ae4b724dec62dceb6d459e80a240f7d353843f3ed73c217ade693c9fcdede775e270b98a58dd3bbacaa7c74332856a1421e"} 09:00:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:00:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:00:06 INFO - Contents: 09:00:06 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/511f3561402c10b17194714063be0fc386f88c47efd9263f3da3a13525358d0e50abea0b50ecce52a7eece35a7026c9e3cd5c82b6780f2e5e29943f370fb2f2b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7c468e1f6c97761fbe8d0c93cc4007fd24c64fd6f4407458ce556159f242ec671ae05cdbc991b860623304f7c4ffda47624568ca4c81d232dae126cb8ee72d07", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fd8ef4cfe7f33dd2be03beb840611ae4b724dec62dceb6d459e80a240f7d353843f3ed73c217ade693c9fcdede775e270b98a58dd3bbacaa7c74332856a1421e"} 09:00:06 INFO - Running post-run listener: copy_logs_to_upload_dir 09:00:06 INFO - Copying logs to upload dir... 09:00:06 INFO - mkdir: /builds/slave/test/build/upload/logs 09:00:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.127108 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-12-14 09:00:06.344119) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-14 09:00:06.347314) ========= 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.eD1gXVJ0a6/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.tZlBNLvpfB/Listeners TMPDIR=/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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/511f3561402c10b17194714063be0fc386f88c47efd9263f3da3a13525358d0e50abea0b50ecce52a7eece35a7026c9e3cd5c82b6780f2e5e29943f370fb2f2b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7c468e1f6c97761fbe8d0c93cc4007fd24c64fd6f4407458ce556159f242ec671ae05cdbc991b860623304f7c4ffda47624568ca4c81d232dae126cb8ee72d07", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fd8ef4cfe7f33dd2be03beb840611ae4b724dec62dceb6d459e80a240f7d353843f3ed73c217ade693c9fcdede775e270b98a58dd3bbacaa7c74332856a1421e"} build_url:https://queue.taskcluster.net/v1/task/UkCE7Au-Q--otQSh6_WDVQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011428 build_url: 'https://queue.taskcluster.net/v1/task/UkCE7Au-Q--otQSh6_WDVQ/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/511f3561402c10b17194714063be0fc386f88c47efd9263f3da3a13525358d0e50abea0b50ecce52a7eece35a7026c9e3cd5c82b6780f2e5e29943f370fb2f2b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7c468e1f6c97761fbe8d0c93cc4007fd24c64fd6f4407458ce556159f242ec671ae05cdbc991b860623304f7c4ffda47624568ca4c81d232dae126cb8ee72d07", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fd8ef4cfe7f33dd2be03beb840611ae4b724dec62dceb6d459e80a240f7d353843f3ed73c217ade693c9fcdede775e270b98a58dd3bbacaa7c74332856a1421e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-14 09:00:06.381990) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 09:00:06.382321) ========= 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.eD1gXVJ0a6/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.tZlBNLvpfB/Listeners TMPDIR=/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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.005188 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 09:00:06.430765) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-14 09:00:06.431092) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-14 09:00:06.431408) ========= ========= Total master_lag: 2.71 =========