builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0215 starttime: 1479949843.68 results: success (0) buildid: 20161123154536 builduid: 98ae40deb2de40bd82816c91a2a19527 revision: f8cd956e52d6e2ab6c2d3fb802f5aaef544f0d32 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-23 17:10:43.679238) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-23 17:10:43.679764) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-23 17:10:43.680073) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-23 17:10:43.705228) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 17:10:43.705572) ========= 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.oKUimPGioa/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.0VejsYx8FQ/Listeners TMPDIR=/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-23 17:10:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 147M=0s 2016-11-23 17:10:43 (147 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.130961 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 17:10:43.859998) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 17:10:43.860317) ========= 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.oKUimPGioa/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.0VejsYx8FQ/Listeners TMPDIR=/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/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.021447 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 17:10:43.908804) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-23 17:10:43.909364) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev f8cd956e52d6e2ab6c2d3fb802f5aaef544f0d32 --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 f8cd956e52d6e2ab6c2d3fb802f5aaef544f0d32 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.oKUimPGioa/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.0VejsYx8FQ/Listeners TMPDIR=/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-23 17:10:43,990 truncating revision to first 12 chars 2016-11-23 17:10:43,990 Setting DEBUG logging. 2016-11-23 17:10:43,990 attempt 1/10 2016-11-23 17:10:43,991 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/f8cd956e52d6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-23 17:10:45,382 unpacking tar archive at: mozilla-beta-f8cd956e52d6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.673226 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-23 17:10:45.606682) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-23 17:10:45.607052) ========= script_repo_revision: f8cd956e52d6e2ab6c2d3fb802f5aaef544f0d32 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-23 17:10:45.607443) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-23 17:10:45.607718) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-23 17:10:45.627428) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-11-23 17:10:45.627827) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.oKUimPGioa/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.0VejsYx8FQ/Listeners TMPDIR=/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/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 17:10:45 INFO - MultiFileLogger online at 20161123 17:10:45 in /builds/slave/test 17:10:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 17:10:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:10:45 INFO - {'append_to_log': False, 17:10:45 INFO - 'base_work_dir': '/builds/slave/test', 17:10:45 INFO - 'blob_upload_branch': 'Mozilla-Beta', 17:10:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:10:45 INFO - 'branch': 'Mozilla-Beta', 17:10:45 INFO - 'buildbot_json_path': 'buildprops.json', 17:10:45 INFO - 'config_files': ('talos/mac_config.py',), 17:10:45 INFO - 'default_actions': ('clobber', 17:10:45 INFO - 'read-buildbot-config', 17:10:45 INFO - 'download-and-extract', 17:10:45 INFO - 'populate-webroot', 17:10:45 INFO - 'create-virtualenv', 17:10:45 INFO - 'install', 17:10:45 INFO - 'run-tests'), 17:10:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:10:45 INFO - 'download_minidump_stackwalk': True, 17:10:45 INFO - 'download_symbols': 'ondemand', 17:10:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:10:45 INFO - 'tooltool.py': '/tools/tooltool.py', 17:10:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:10:45 INFO - '/tools/misc-python/virtualenv.py')}, 17:10:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:10:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:10:45 INFO - 'installer_path': 'installer.exe', 17:10:45 INFO - 'log_level': 'info', 17:10:45 INFO - 'log_name': 'talos', 17:10:45 INFO - 'log_to_console': True, 17:10:45 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:10:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:10:45 INFO - 'opt_config_files': (), 17:10:45 INFO - 'pip_index': False, 17:10:45 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:10:45 INFO - 'cmd': ('bash', 17:10:45 INFO - '-c', 17:10:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:10:45 INFO - 'enabled': True, 17:10:45 INFO - 'halt_on_failure': False, 17:10:45 INFO - 'name': 'check_screen_resolution'},), 17:10:45 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:10:45 INFO - 'cmd': ('bash', 17:10:45 INFO - '-c', 17:10:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:10:45 INFO - 'enabled': True, 17:10:45 INFO - 'halt_on_failure': False, 17:10:45 INFO - 'name': 'check_screen_resolution'},), 17:10:45 INFO - 'run_cmd_checks_enabled': True, 17:10:45 INFO - 'sps_profile': False, 17:10:45 INFO - 'sps_profile_interval': 0, 17:10:45 INFO - 'suite': 'dromaeojs', 17:10:45 INFO - 'system_bits': '32', 17:10:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:10:45 INFO - 'title': 't-yosemite-r7-0215', 17:10:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:10:45 INFO - 'use_talos_json': True, 17:10:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:10:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:10:45 INFO - 'work_dir': 'build'} 17:10:45 INFO - [mozharness: 2016-11-24 01:10:45.823169Z] Running clobber step. 17:10:45 INFO - Running pre-action listener: _resource_record_pre_action 17:10:45 INFO - Running main action method: clobber 17:10:45 INFO - rmtree: /builds/slave/test/build 17:10:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:10:47 INFO - Running post-action listener: _resource_record_post_action 17:10:47 INFO - [mozharness: 2016-11-24 01:10:47.479629Z] Finished clobber step (success) 17:10:47 INFO - [mozharness: 2016-11-24 01:10:47.479751Z] Running read-buildbot-config step. 17:10:47 INFO - Running pre-action listener: _resource_record_pre_action 17:10:47 INFO - Running main action method: read_buildbot_config 17:10:47 INFO - Using buildbot properties: 17:10:47 INFO - { 17:10:47 INFO - "project": "", 17:10:47 INFO - "product": "firefox", 17:10:47 INFO - "script_repo_revision": "production", 17:10:47 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 17:10:47 INFO - "repository": "", 17:10:47 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 17:10:47 INFO - "buildid": "20161123154536", 17:10:47 INFO - "pgo_build": "False", 17:10:47 INFO - "basedir": "/builds/slave/test", 17:10:47 INFO - "buildnumber": 21, 17:10:47 INFO - "slavename": "t-yosemite-r7-0215", 17:10:47 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 17:10:47 INFO - "platform": "yosemite_r7", 17:10:47 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 17:10:47 INFO - "branch": "mozilla-beta", 17:10:47 INFO - "repo_path": "releases/mozilla-beta", 17:10:47 INFO - "revision": "f8cd956e52d6e2ab6c2d3fb802f5aaef544f0d32", 17:10:47 INFO - "stage_platform": "macosx64", 17:10:47 INFO - "builduid": "98ae40deb2de40bd82816c91a2a19527", 17:10:47 INFO - "slavebuilddir": "test" 17:10:47 INFO - } 17:10:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/dbA-lTQ3SumMH8itJ64e8A/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 17:10:47 INFO - Running post-action listener: _resource_record_post_action 17:10:47 INFO - [mozharness: 2016-11-24 01:10:47.483255Z] Finished read-buildbot-config step (success) 17:10:47 INFO - [mozharness: 2016-11-24 01:10:47.483372Z] Running download-and-extract step. 17:10:47 INFO - Running pre-action listener: _resource_record_pre_action 17:10:47 INFO - Running main action method: download_and_extract 17:10:47 INFO - mkdir: /builds/slave/test/build/tests 17:10: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')]} 17:10:47 INFO - trying https://queue.taskcluster.net/v1/task/dbA-lTQ3SumMH8itJ64e8A/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 17:10:47 INFO - Downloading https://queue.taskcluster.net/v1/task/dbA-lTQ3SumMH8itJ64e8A/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 17:10:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dbA-lTQ3SumMH8itJ64e8A/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 17:10:48 INFO - Downloaded 1165 bytes. 17:10:48 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 17:10:48 INFO - Using the following test package requirements: 17:10:48 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 17:10:48 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 17:10:48 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 17:10:48 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 17:10:48 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 17:10:48 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 17:10:48 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 17:10:48 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 17:10:48 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 17:10:48 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 17:10:48 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 17:10:48 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 17:10:48 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 17:10:48 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 17:10:48 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 17:10:48 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 17:10:48 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 17:10:48 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 17:10:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dbA-lTQ3SumMH8itJ64e8A/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 17:10:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dbA-lTQ3SumMH8itJ64e8A/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 17:10:48 INFO - Fetch https://queue.taskcluster.net/v1/task/dbA-lTQ3SumMH8itJ64e8A/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 17:10:49 INFO - Expected file size: 16232531 17:10:56 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 17:10:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dbA-lTQ3SumMH8itJ64e8A/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 17:10:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dbA-lTQ3SumMH8itJ64e8A/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 17:10:56 INFO - Fetch https://queue.taskcluster.net/v1/task/dbA-lTQ3SumMH8itJ64e8A/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 17:10:56 INFO - Expected file size: 16232531 17:11:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dbA-lTQ3SumMH8itJ64e8A/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 17:11:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dbA-lTQ3SumMH8itJ64e8A/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 17:11:03 INFO - Fetch https://queue.taskcluster.net/v1/task/dbA-lTQ3SumMH8itJ64e8A/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 17:11:03 INFO - Expected file size: 14414089 17:11:04 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')]} 17:11:04 INFO - trying https://queue.taskcluster.net/v1/task/dbA-lTQ3SumMH8itJ64e8A/artifacts/public/build/firefox-51.0.en-US.mac.dmg 17:11:04 INFO - Downloading https://queue.taskcluster.net/v1/task/dbA-lTQ3SumMH8itJ64e8A/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 17:11:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dbA-lTQ3SumMH8itJ64e8A/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 17:11:06 INFO - Downloaded 86045520 bytes. 17:11:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dbA-lTQ3SumMH8itJ64e8A/artifacts/public/build/firefox-51.0.en-US.mac.dmg 17:11:06 INFO - mkdir: /builds/slave/test/properties 17:11:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:11:06 INFO - Writing to file /builds/slave/test/properties/build_url 17:11:06 INFO - Contents: 17:11:06 INFO - build_url:https://queue.taskcluster.net/v1/task/dbA-lTQ3SumMH8itJ64e8A/artifacts/public/build/firefox-51.0.en-US.mac.dmg 17:11:07 INFO - Running post-action listener: _resource_record_post_action 17:11:07 INFO - Running post-action listener: set_extra_try_arguments 17:11:07 INFO - [mozharness: 2016-11-24 01:11:07.485394Z] Finished download-and-extract step (success) 17:11:07 INFO - [mozharness: 2016-11-24 01:11:07.485497Z] Running populate-webroot step. 17:11:07 INFO - Running pre-action listener: _resource_record_pre_action 17:11:07 INFO - Running main action method: populate_webroot 17:11:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:11:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:11:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:11:07 INFO - '--tppagecycles', 17:11:07 INFO - '7'], 17:11:07 INFO - 'tests': ['tsvgm']}}, 17:11:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:11:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:11:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:11:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:11:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:11:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:11:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:11:07 INFO - 'talos_options': ['--disable-e10s'], 17:11:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:11:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:11:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:11:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:11:07 INFO - 'talos_options': ['--disable-e10s'], 17:11:07 INFO - 'tests': ['damp', 'tps']}, 17:11:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:11:07 INFO - 'tests': ['damp', 'tps']}, 17:11:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:11:07 INFO - 'tests': ['dromaeo_dom']}, 17:11:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:11:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:11:07 INFO - 'tests': ['basic_compositor_video']}, 17:11:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:11:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:11:07 INFO - 'tests': ['a11yr', 17:11:07 INFO - 'ts_paint', 17:11:07 INFO - 'tpaint', 17:11:07 INFO - 'sessionrestore', 17:11:07 INFO - 'sessionrestore_no_auto_restore', 17:11:07 INFO - 'tabpaint']}, 17:11:07 INFO - 'other-e10s': {'tests': ['a11yr', 17:11:07 INFO - 'ts_paint', 17:11:07 INFO - 'tpaint', 17:11:07 INFO - 'sessionrestore', 17:11:07 INFO - 'sessionrestore_no_auto_restore', 17:11:07 INFO - 'tabpaint']}, 17:11:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:11:07 INFO - 'ts_paint', 17:11:07 INFO - 'tpaint', 17:11:07 INFO - 'sessionrestore', 17:11:07 INFO - 'sessionrestore_no_auto_restore', 17:11:07 INFO - 'tabpaint']}, 17:11:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:11:07 INFO - 'ts_paint', 17:11:07 INFO - 'tpaint', 17:11:07 INFO - 'sessionrestore', 17:11:07 INFO - 'sessionrestore_no_auto_restore', 17:11:07 INFO - 'tabpaint']}, 17:11:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:11:07 INFO - 'tests': ['a11yr', 17:11:07 INFO - 'ts_paint', 17:11:07 INFO - 'tpaint', 17:11:07 INFO - 'sessionrestore', 17:11:07 INFO - 'sessionrestore_no_auto_restore', 17:11:07 INFO - 'tabpaint']}, 17:11:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:11:07 INFO - 'tests': ['a11yr', 17:11:07 INFO - 'ts_paint', 17:11:07 INFO - 'tpaint', 17:11:07 INFO - 'sessionrestore', 17:11:07 INFO - 'sessionrestore_no_auto_restore', 17:11:07 INFO - 'tabpaint']}, 17:11:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:11:07 INFO - 'tests': ['tsvgx', 17:11:07 INFO - 'tsvgr_opacity', 17:11:07 INFO - 'tart', 17:11:07 INFO - 'tscrollx', 17:11:07 INFO - 'cart']}, 17:11:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:11:07 INFO - 'tsvgr_opacity', 17:11:07 INFO - 'tart', 17:11:07 INFO - 'tscrollx', 17:11:07 INFO - 'cart']}, 17:11:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:11:07 INFO - 'talos_options': ['--disable-e10s'], 17:11:07 INFO - 'tests': ['tp5o']}, 17:11:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:11:07 INFO - 'tests': ['tp5o']}, 17:11:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:11:07 INFO - 'talos_options': ['--disable-e10s', 17:11:07 INFO - '--xperf_path', 17:11:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:11:07 INFO - 'tests': ['tp5n']}, 17:11:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:11:07 INFO - 'talos_options': ['--xperf_path', 17:11:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:11:07 INFO - 'tests': ['tp5n']}}, 17:11:07 INFO - 'talos.zip': {'path': '', 17:11:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:11:07 INFO - Running post-action listener: _resource_record_post_action 17:11:07 INFO - [mozharness: 2016-11-24 01:11:07.504163Z] Finished populate-webroot step (success) 17:11:07 INFO - [mozharness: 2016-11-24 01:11:07.504292Z] Running create-virtualenv step. 17:11:07 INFO - Running pre-action listener: _resource_record_pre_action 17:11:07 INFO - Running main action method: create_virtualenv 17:11:07 INFO - Creating virtualenv /builds/slave/test/build/venv 17:11:07 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 17:11:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:11:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:11:07 INFO - Using real prefix '/tools/python27' 17:11:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:11:08 INFO - Installing distribute.............................................................................................................................................................................................done. 17:11:11 INFO - Installing pip.................done. 17:11:11 INFO - Return code: 0 17:11:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:11: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')]} 17:11:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11: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')]} 17:11:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:11 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 0x10fdd2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd48570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e1056a2c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbe6d30>, '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 0x10fa4cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbdeb20>, '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.oKUimPGioa/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.0VejsYx8FQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/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 17:11:11 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 17:11:11 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 17:11:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oKUimPGioa/Render', 17:11:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:11:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:11:11 INFO - 'HOME': '/Users/cltbld', 17:11:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:11:11 INFO - 'LOGNAME': 'cltbld', 17:11:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:11 INFO - 'MOZ_NO_REMOTE': '1', 17:11:11 INFO - 'NO_EM_RESTART': '1', 17:11:11 INFO - 'PAGER': '/bin/cat', 17:11:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:11:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:11 INFO - 'PWD': '/builds/slave/test', 17:11:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:11:11 INFO - 'SHELL': '/bin/bash', 17:11:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0VejsYx8FQ/Listeners', 17:11:11 INFO - 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/', 17:11:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:11:11 INFO - 'USER': 'cltbld', 17:11:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:11:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:11:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:11 INFO - 'XPC_FLAGS': '0x0', 17:11:11 INFO - 'XPC_SERVICE_NAME': '0', 17:11:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:11:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:11 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 17:11:11 INFO - Cleaning up... 17:11:11 INFO - Return code: 0 17:11:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:11: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')]} 17:11:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11: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')]} 17:11:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:11 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 0x10fdd2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd48570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e1056a2c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbe6d30>, '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 0x10fa4cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbdeb20>, '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.oKUimPGioa/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.0VejsYx8FQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/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 17:11:11 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 17:11:11 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 17:11:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oKUimPGioa/Render', 17:11:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:11:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:11:11 INFO - 'HOME': '/Users/cltbld', 17:11:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:11:11 INFO - 'LOGNAME': 'cltbld', 17:11:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:11 INFO - 'MOZ_NO_REMOTE': '1', 17:11:11 INFO - 'NO_EM_RESTART': '1', 17:11:11 INFO - 'PAGER': '/bin/cat', 17:11:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:11:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:11 INFO - 'PWD': '/builds/slave/test', 17:11:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:11:11 INFO - 'SHELL': '/bin/bash', 17:11:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0VejsYx8FQ/Listeners', 17:11:11 INFO - 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/', 17:11:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:11:11 INFO - 'USER': 'cltbld', 17:11:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:11:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:11:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:11 INFO - 'XPC_FLAGS': '0x0', 17:11:11 INFO - 'XPC_SERVICE_NAME': '0', 17:11:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:11:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:11 INFO - Downloading/unpacking psutil>=3.1.1 17:11:11 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 17:11:11 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 17:11:11 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 17:11:11 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 17:11:11 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 17:11:11 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 17:11:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:11:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:11:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:11:15 INFO - Installing collected packages: psutil 17:11:15 INFO - Running setup.py install for psutil 17:11:15 INFO - building 'psutil._psutil_osx' extension 17:11:15 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 17:11:15 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 17:11:15 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 17:11:15 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 17:11:15 INFO - building 'psutil._psutil_posix' extension 17:11:15 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 17:11:15 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:11:15 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:11:15 INFO - ^ 17:11:15 INFO - 1 warning generated. 17:11:15 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 17:11:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:11:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:11:15 INFO - Successfully installed psutil 17:11:15 INFO - Cleaning up... 17:11:16 INFO - Return code: 0 17:11:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:11:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:11:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:11:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:16 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 0x10fdd2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd48570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e1056a2c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbe6d30>, '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 0x10fa4cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbdeb20>, '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.oKUimPGioa/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.0VejsYx8FQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/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 17:11:16 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 17:11:16 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 17:11:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oKUimPGioa/Render', 17:11:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:11:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:11:16 INFO - 'HOME': '/Users/cltbld', 17:11:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:11:16 INFO - 'LOGNAME': 'cltbld', 17:11:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:16 INFO - 'MOZ_NO_REMOTE': '1', 17:11:16 INFO - 'NO_EM_RESTART': '1', 17:11:16 INFO - 'PAGER': '/bin/cat', 17:11:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:11:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:16 INFO - 'PWD': '/builds/slave/test', 17:11:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:11:16 INFO - 'SHELL': '/bin/bash', 17:11:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0VejsYx8FQ/Listeners', 17:11:16 INFO - 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/', 17:11:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:11:16 INFO - 'USER': 'cltbld', 17:11:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:11:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:11:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:16 INFO - 'XPC_FLAGS': '0x0', 17:11:16 INFO - 'XPC_SERVICE_NAME': '0', 17:11:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:11:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:11:16 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 17:11:16 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 17:11:16 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 17:11:16 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 17:11:16 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 17:11:16 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 17:11:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:11:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:11:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:11:19 INFO - Installing collected packages: mozsystemmonitor 17:11:19 INFO - Running setup.py install for mozsystemmonitor 17:11:19 INFO - Successfully installed mozsystemmonitor 17:11:19 INFO - Cleaning up... 17:11:19 INFO - Return code: 0 17:11:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:11:19 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')]} 17:11:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:19 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')]} 17:11:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:19 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 0x10fdd2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd48570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e1056a2c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbe6d30>, '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 0x10fa4cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbdeb20>, '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.oKUimPGioa/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.0VejsYx8FQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/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 17:11:19 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 17:11:19 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 17:11:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oKUimPGioa/Render', 17:11:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:11:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:11:19 INFO - 'HOME': '/Users/cltbld', 17:11:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:11:19 INFO - 'LOGNAME': 'cltbld', 17:11:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:19 INFO - 'MOZ_NO_REMOTE': '1', 17:11:19 INFO - 'NO_EM_RESTART': '1', 17:11:19 INFO - 'PAGER': '/bin/cat', 17:11:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:11:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:19 INFO - 'PWD': '/builds/slave/test', 17:11:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:11:19 INFO - 'SHELL': '/bin/bash', 17:11:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0VejsYx8FQ/Listeners', 17:11:19 INFO - 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/', 17:11:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:11:19 INFO - 'USER': 'cltbld', 17:11:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:11:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:11:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:19 INFO - 'XPC_FLAGS': '0x0', 17:11:19 INFO - 'XPC_SERVICE_NAME': '0', 17:11:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:11:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:19 INFO - Downloading/unpacking jsonschema==2.5.1 17:11:19 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 17:11:19 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 17:11:19 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 17:11:19 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 17:11:19 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 17:11:19 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 17:11:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:11:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:11:22 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 17:11:22 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 17:11:22 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 17:11:22 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 17:11:22 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 17:11:22 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 17:11:22 INFO - Downloading functools32-3.2.3-2.tar.gz 17:11:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:11:22 INFO - warning: no files found matching '*.txt' 17:11:22 INFO - no previously-included directories found matching 'build' 17:11:22 INFO - no previously-included directories found matching 'dist' 17:11:22 INFO - no previously-included directories found matching '.git*' 17:11:22 INFO - Installing collected packages: jsonschema, functools32 17:11:22 INFO - Running setup.py install for functools32 17:11:22 INFO - warning: no files found matching '*.txt' 17:11:22 INFO - no previously-included directories found matching 'build' 17:11:22 INFO - no previously-included directories found matching 'dist' 17:11:22 INFO - no previously-included directories found matching '.git*' 17:11:22 INFO - Successfully installed jsonschema functools32 17:11:22 INFO - Cleaning up... 17:11:22 INFO - Return code: 0 17:11:22 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:11:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:11:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:11:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:22 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 0x10fdd2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd48570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e1056a2c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbe6d30>, '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 0x10fa4cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbdeb20>, '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.oKUimPGioa/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.0VejsYx8FQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/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 17:11:22 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 17:11:22 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 17:11:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oKUimPGioa/Render', 17:11:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:11:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:11:22 INFO - 'HOME': '/Users/cltbld', 17:11:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:11:22 INFO - 'LOGNAME': 'cltbld', 17:11:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:22 INFO - 'MOZ_NO_REMOTE': '1', 17:11:22 INFO - 'NO_EM_RESTART': '1', 17:11:22 INFO - 'PAGER': '/bin/cat', 17:11:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:11:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:22 INFO - 'PWD': '/builds/slave/test', 17:11:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:11:22 INFO - 'SHELL': '/bin/bash', 17:11:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0VejsYx8FQ/Listeners', 17:11:22 INFO - 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/', 17:11:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:11:22 INFO - 'USER': 'cltbld', 17:11:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:11:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:11:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:22 INFO - 'XPC_FLAGS': '0x0', 17:11:22 INFO - 'XPC_SERVICE_NAME': '0', 17:11:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:11:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:11:23 INFO - Cleaning up... 17:11:23 INFO - Return code: 0 17:11:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:11:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:11:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:11:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10fdd2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd48570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e1056a2c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbe6d30>, '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 0x10fa4cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbdeb20>, '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.oKUimPGioa/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.0VejsYx8FQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/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 17:11:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:11:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:11:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oKUimPGioa/Render', 17:11:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:11:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:11:23 INFO - 'HOME': '/Users/cltbld', 17:11:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:11:23 INFO - 'LOGNAME': 'cltbld', 17:11:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:23 INFO - 'MOZ_NO_REMOTE': '1', 17:11:23 INFO - 'NO_EM_RESTART': '1', 17:11:23 INFO - 'PAGER': '/bin/cat', 17:11:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:11:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:23 INFO - 'PWD': '/builds/slave/test', 17:11:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:11:23 INFO - 'SHELL': '/bin/bash', 17:11:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0VejsYx8FQ/Listeners', 17:11:23 INFO - 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/', 17:11:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:11:23 INFO - 'USER': 'cltbld', 17:11:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:11:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:11:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:23 INFO - 'XPC_FLAGS': '0x0', 17:11:23 INFO - 'XPC_SERVICE_NAME': '0', 17:11:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:11:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:23 INFO - Downloading/unpacking blobuploader==1.2.4 17:11:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:11:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:11:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:11:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:11:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:11:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:11:25 INFO - Downloading blobuploader-1.2.4.tar.gz 17:11:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:11:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:11:25 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 17:11:25 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 17:11:25 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 17:11:25 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 17:11:25 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 17:11:25 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 17:11:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:11:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:11:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:11:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:11:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:11:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:11:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:11:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:11:26 INFO - Downloading docopt-0.6.1.tar.gz 17:11:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:11:27 INFO - Installing collected packages: blobuploader, requests, docopt 17:11:27 INFO - Running setup.py install for blobuploader 17:11:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:11:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:11:27 INFO - Running setup.py install for requests 17:11:27 INFO - Running setup.py install for docopt 17:11:27 INFO - Successfully installed blobuploader requests docopt 17:11:27 INFO - Cleaning up... 17:11:27 INFO - Return code: 0 17:11:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:11:27 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')]} 17:11:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:27 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')]} 17:11:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:27 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 0x10fdd2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd48570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e1056a2c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbe6d30>, '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 0x10fa4cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbdeb20>, '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.oKUimPGioa/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.0VejsYx8FQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/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 17:11:27 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 17:11:27 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 17:11:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oKUimPGioa/Render', 17:11:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:11:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:11:27 INFO - 'HOME': '/Users/cltbld', 17:11:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:11:27 INFO - 'LOGNAME': 'cltbld', 17:11:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:27 INFO - 'MOZ_NO_REMOTE': '1', 17:11:27 INFO - 'NO_EM_RESTART': '1', 17:11:27 INFO - 'PAGER': '/bin/cat', 17:11:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:11:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:27 INFO - 'PWD': '/builds/slave/test', 17:11:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:11:27 INFO - 'SHELL': '/bin/bash', 17:11:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0VejsYx8FQ/Listeners', 17:11:27 INFO - 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/', 17:11:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:11:27 INFO - 'USER': 'cltbld', 17:11:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:11:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:11:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:27 INFO - 'XPC_FLAGS': '0x0', 17:11:27 INFO - 'XPC_SERVICE_NAME': '0', 17:11:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:11:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:11:28 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-Yop0Vg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:11:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:11:28 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-fhM8ky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:11:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:11:28 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-vAooJd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:11:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:11:28 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-QZ0nd0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:11:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:11:28 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-FdQeg5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:11:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:11:28 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-pWE8rb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:11:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:11:28 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-PZBpYY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:11:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:11:28 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-51IPjR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:11:29 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-egJqox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:11:29 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-jYbIB0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:11:29 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-EmuzCc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:11:29 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-SDvQwa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:11:29 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-ufZ6DI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:11:29 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-0Kh8lr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:11:29 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-fvrgtm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:11:29 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-sV4rwl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:11:29 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-0mQULh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:11:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:11:30 INFO - Running setup.py install for manifestparser 17:11:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:11:30 INFO - Running setup.py install for mozcrash 17:11:30 INFO - Running setup.py install for mozdebug 17:11:30 INFO - Running setup.py install for mozdevice 17:11:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:11:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:11:30 INFO - Running setup.py install for mozfile 17:11:30 INFO - Running setup.py install for mozhttpd 17:11:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:11:30 INFO - Running setup.py install for mozinfo 17:11:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:11:31 INFO - Running setup.py install for mozInstall 17:11:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:11:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:11:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:11:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:11:31 INFO - Running setup.py install for mozleak 17:11:31 INFO - Running setup.py install for mozlog 17:11:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:11:31 INFO - Running setup.py install for moznetwork 17:11:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:11:31 INFO - Running setup.py install for mozprocess 17:11:31 INFO - Running setup.py install for mozprofile 17:11:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:11:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:11:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:11:31 INFO - Running setup.py install for mozrunner 17:11:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:11:32 INFO - Running setup.py install for mozscreenshot 17:11:32 INFO - Running setup.py install for moztest 17:11:32 INFO - Running setup.py install for mozversion 17:11:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:11:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:11:32 INFO - Cleaning up... 17:11:32 INFO - Return code: 0 17:11:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:11:32 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')]} 17:11:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:32 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')]} 17:11:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:32 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 0x10fdd2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd48570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e1056a2c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbe6d30>, '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 0x10fa4cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbdeb20>, '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.oKUimPGioa/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.0VejsYx8FQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/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 17:11:32 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 17:11:32 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 17:11:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oKUimPGioa/Render', 17:11:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:11:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:11:32 INFO - 'HOME': '/Users/cltbld', 17:11:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:11:32 INFO - 'LOGNAME': 'cltbld', 17:11:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:32 INFO - 'MOZ_NO_REMOTE': '1', 17:11:32 INFO - 'NO_EM_RESTART': '1', 17:11:32 INFO - 'PAGER': '/bin/cat', 17:11:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:11:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:32 INFO - 'PWD': '/builds/slave/test', 17:11:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:11:32 INFO - 'SHELL': '/bin/bash', 17:11:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0VejsYx8FQ/Listeners', 17:11:32 INFO - 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/', 17:11:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:11:32 INFO - 'USER': 'cltbld', 17:11:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:11:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:11:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:32 INFO - 'XPC_FLAGS': '0x0', 17:11:32 INFO - 'XPC_SERVICE_NAME': '0', 17:11:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:11:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:11:32 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-idd_dw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:11:33 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)) 17:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:11:33 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-CgjrSR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:11:33 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)) 17:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:11:33 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-dGvtOf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:11:33 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)) 17:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:11:33 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-wQdAWW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:11:33 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)) 17:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:11:33 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-8MerCv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:11:33 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)) 17:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:11:33 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-PrIJeN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:11:33 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)) 17:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:11:33 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-x50z5z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:11:33 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)) 17:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:11:33 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-jZ35FY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:11:33 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)) 17:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:11:33 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-i8Wg1W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:11:33 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)) 17:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:11:33 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-uJRnxD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:11:33 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)) 17:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:11:33 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-pjcJk9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:11:34 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)) 17:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:11:34 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-g21H_d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:11:34 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)) 17:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:11:34 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-FS7uY5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:11:34 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)) 17:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:11:34 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-beFC8a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:11:34 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)) 17:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:11:34 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-WWw0lL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:11:34 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)) 17:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:11:34 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-SdqaPb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:11:34 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)) 17:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:11:34 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-hOS52U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:11:34 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)) 17:11:34 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)) 17:11:34 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)) 17:11:34 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)) 17:11:34 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)) 17:11:34 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)) 17:11:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:11:34 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 17:11:34 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 17:11:34 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 17:11:34 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 17:11:34 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 17:11:34 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 17:11:37 INFO - Downloading blessings-1.6.tar.gz 17:11:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:11:37 INFO - Installing collected packages: blessings 17:11:37 INFO - Running setup.py install for blessings 17:11:37 INFO - Successfully installed blessings 17:11:37 INFO - Cleaning up... 17:11:37 INFO - Return code: 0 17:11:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:11:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:11:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:11:37 INFO - Reading from file tmpfile_stdout 17:11:37 INFO - Current package versions: 17:11:37 INFO - blessings == 1.6 17:11:37 INFO - blobuploader == 1.2.4 17:11:37 INFO - docopt == 0.6.1 17:11:37 INFO - functools32 == 3.2.3-2 17:11:37 INFO - jsonschema == 2.5.1 17:11:37 INFO - manifestparser == 1.1 17:11:37 INFO - mozInstall == 1.12 17:11:37 INFO - mozcrash == 0.17 17:11:37 INFO - mozdebug == 0.1 17:11:37 INFO - mozdevice == 0.48 17:11:37 INFO - mozfile == 1.2 17:11:37 INFO - mozhttpd == 0.7 17:11:37 INFO - mozinfo == 0.9 17:11:37 INFO - mozleak == 0.1 17:11:37 INFO - mozlog == 3.4 17:11:37 INFO - moznetwork == 0.27 17:11:37 INFO - mozprocess == 0.23 17:11:37 INFO - mozprofile == 0.28 17:11:37 INFO - mozrunner == 6.12 17:11:37 INFO - mozscreenshot == 0.1 17:11:37 INFO - mozsystemmonitor == 0.3 17:11:37 INFO - moztest == 0.7 17:11:37 INFO - mozversion == 1.4 17:11:37 INFO - psutil == 3.1.1 17:11:37 INFO - requests == 1.2.3 17:11:37 INFO - wsgiref == 0.1.2 17:11:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:11:37 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')]} 17:11:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:37 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')]} 17:11:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:37 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 0x10fdd2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd48570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e1056a2c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbe6d30>, '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 0x10fa4cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbdeb20>, '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.oKUimPGioa/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.0VejsYx8FQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/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 17:11:37 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 17:11:37 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 17:11:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oKUimPGioa/Render', 17:11:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:11:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:11:37 INFO - 'HOME': '/Users/cltbld', 17:11:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:11:37 INFO - 'LOGNAME': 'cltbld', 17:11:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:37 INFO - 'MOZ_NO_REMOTE': '1', 17:11:37 INFO - 'NO_EM_RESTART': '1', 17:11:37 INFO - 'PAGER': '/bin/cat', 17:11:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:11:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:37 INFO - 'PWD': '/builds/slave/test', 17:11:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:11:37 INFO - 'SHELL': '/bin/bash', 17:11:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0VejsYx8FQ/Listeners', 17:11:37 INFO - 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/', 17:11:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:11:37 INFO - 'USER': 'cltbld', 17:11:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:11:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:11:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:37 INFO - 'XPC_FLAGS': '0x0', 17:11:37 INFO - 'XPC_SERVICE_NAME': '0', 17:11:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:11:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:38 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)) 17:11:38 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)) 17:11:38 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)) 17:11:38 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)) 17:11:38 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)) 17:11:38 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)) 17:11:38 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)) 17:11:38 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)) 17:11:38 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)) 17:11:38 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)) 17:11:38 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)) 17:11:38 INFO - Cleaning up... 17:11:38 INFO - Return code: 0 17:11:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:11:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:11:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:11:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:11:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:11:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:11:38 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 0x10fdd2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd48570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e1056a2c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbe6d30>, '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 0x10fa4cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbdeb20>, '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.oKUimPGioa/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.0VejsYx8FQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/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 17:11:38 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 17:11:38 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 17:11:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oKUimPGioa/Render', 17:11:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:11:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:11:38 INFO - 'HOME': '/Users/cltbld', 17:11:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:11:38 INFO - 'LOGNAME': 'cltbld', 17:11:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:11:38 INFO - 'MOZ_NO_REMOTE': '1', 17:11:38 INFO - 'NO_EM_RESTART': '1', 17:11:38 INFO - 'PAGER': '/bin/cat', 17:11:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:11:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:11:38 INFO - 'PWD': '/builds/slave/test', 17:11:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:11:38 INFO - 'SHELL': '/bin/bash', 17:11:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0VejsYx8FQ/Listeners', 17:11:38 INFO - 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/', 17:11:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:11:38 INFO - 'USER': 'cltbld', 17:11:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:11:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:11:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:11:38 INFO - 'XPC_FLAGS': '0x0', 17:11:38 INFO - 'XPC_SERVICE_NAME': '0', 17:11:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:11:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:11:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:11:38 INFO - Cleaning up... 17:11:38 INFO - Return code: 0 17:11:38 INFO - Running post-action listener: _resource_record_post_action 17:11:38 INFO - Running post-action listener: _start_resource_monitoring 17:11:38 INFO - Starting resource monitoring. 17:11:38 INFO - [mozharness: 2016-11-24 01:11:38.478058Z] Finished create-virtualenv step (success) 17:11:38 INFO - [mozharness: 2016-11-24 01:11:38.479134Z] Running install step. 17:11:38 INFO - Running pre-action listener: _resource_record_pre_action 17:11:38 INFO - Running main action method: install 17:11:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:11:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:11:38 INFO - Reading from file tmpfile_stdout 17:11:38 INFO - Detecting whether we're running mozinstall >=1.0... 17:11:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:11:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:11:38 INFO - Reading from file tmpfile_stdout 17:11:38 INFO - Output received: 17:11:38 INFO - Usage: mozinstall [options] installer 17:11:38 INFO - Options: 17:11:38 INFO - -h, --help show this help message and exit 17:11:38 INFO - -d DEST, --destination=DEST 17:11:38 INFO - Directory to install application into. [default: 17:11:38 INFO - "/builds/slave/test"] 17:11:38 INFO - --app=APP Application being installed. [default: firefox] 17:11:38 INFO - mkdir: /builds/slave/test/build/application 17:11:38 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'] 17:11:38 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 17:12:00 INFO - Reading from file tmpfile_stdout 17:12:00 INFO - Output received: 17:12:00 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 17:12:00 INFO - Running post-action listener: _resource_record_post_action 17:12:00 INFO - [mozharness: 2016-11-24 01:12:00.825004Z] Finished install step (success) 17:12:00 INFO - [mozharness: 2016-11-24 01:12:00.825132Z] Running run-tests step. 17:12:00 INFO - Running pre-action listener: _resource_record_pre_action 17:12:00 INFO - Running main action method: run_tests 17:12:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:12:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:12:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:12:00 INFO - 2016-11-23 17:12:00.840 screenresolution[2167:22226] starting screenresolution argv=screenresolution get 17:12:00 INFO - 2016-11-23 17:12:00.842 screenresolution[2167:22226] Display 0: 1600x1200x32@60 17:12:00 INFO - 2016-11-23 17:12:00.848 screenresolution[2168:22229] starting screenresolution argv=screenresolution list 17:12:00 INFO - Available Modes on Display 0 17:12:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:12:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:12:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:12:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:12:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:12:01 INFO - Intel Iris: 17:12:01 INFO - Chipset Model: Intel Iris 17:12:01 INFO - Type: GPU 17:12:01 INFO - Bus: Built-In 17:12:01 INFO - VRAM (Dynamic, Max): 1536 MB 17:12:01 INFO - Vendor: Intel (0x8086) 17:12:01 INFO - Device ID: 0x0a2e 17:12:01 INFO - Revision ID: 0x0009 17:12:01 INFO - Displays: 17:12:01 INFO - Display: 17:12:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:12:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:12:01 INFO - Display Serial Number: 1600x1200 60 17:12:01 INFO - Main Display: Yes 17:12:01 INFO - Mirror: Off 17:12:01 INFO - Online: Yes 17:12:01 INFO - Rotation: Supported 17:12:01 INFO - Return code: 0 17:12:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:12:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:12:01 INFO - Python 2.7.3 17:12:01 INFO - Return code: 0 17:12:01 INFO - grabbing minidump binary from tooltool 17:12: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')]} 17:12:01 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 0x10fbe6d30>, '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 0x10fa4cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbdeb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:12:01 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 17:12:01 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 17:12:01 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 17:12:01 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:12:01 INFO - Return code: 0 17:12:01 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:12:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:12:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:12:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:12:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:12:01 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', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dbA-lTQ3SumMH8itJ64e8A/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0215', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 17:12:01 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 --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dbA-lTQ3SumMH8itJ64e8A/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0215 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 17:12:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oKUimPGioa/Render', 17:12:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:12:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:12:01 INFO - 'HOME': '/Users/cltbld', 17:12:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:12:01 INFO - 'LOGNAME': 'cltbld', 17:12:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:12:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:12:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:01 INFO - 'MOZ_NO_REMOTE': '1', 17:12:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:12:01 INFO - 'NO_EM_RESTART': '1', 17:12:01 INFO - 'PAGER': '/bin/cat', 17:12:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:12:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:01 INFO - 'PWD': '/builds/slave/test', 17:12:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:12:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:12:01 INFO - 'SHELL': '/bin/bash', 17:12:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0VejsYx8FQ/Listeners', 17:12:01 INFO - 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/', 17:12:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:12:01 INFO - 'USER': 'cltbld', 17:12:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:12:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:12:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:01 INFO - 'XPC_FLAGS': '0x0', 17:12:01 INFO - 'XPC_SERVICE_NAME': '0', 17:12:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:12:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dbA-lTQ3SumMH8itJ64e8A/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0215', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 17:12:01 INFO - mozversion application_buildid: 20161123154536 17:12:01 INFO - mozversion application_changeset: f8cd956e52d6e2ab6c2d3fb802f5aaef544f0d32 17:12:01 INFO - mozversion application_display_name: Firefox 17:12:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:12:01 INFO - mozversion application_name: Firefox 17:12:01 INFO - mozversion application_remotingname: firefox 17:12:01 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 17:12:01 INFO - mozversion application_vendor: Mozilla 17:12:01 INFO - mozversion application_version: 51.0 17:12:01 INFO - mozversion platform_buildid: 20161123154536 17:12:01 INFO - mozversion platform_changeset: f8cd956e52d6e2ab6c2d3fb802f5aaef544f0d32 17:12:01 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 17:12:01 INFO - mozversion platform_version: 51.0 17:12:01 INFO - using testdate: 1479949921 17:12:01 INFO - actual date: 1479949921 17:12:01 INFO - starting webserver on 'localhost:54525' 17:12:01 INFO - SUITE-START | Running 2 tests 17:12:01 INFO - TEST-START | dromaeo_css 17:12:01 INFO - operating with platform_type : mac_ 17:12:01 INFO - Initialising browser for dromaeo_css test... 17:12:01 INFO - TEST-INFO | started process 2178 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/tmp3x1w3j/profile http://localhost:54525/getInfo.html) 17:12:03 INFO - PROCESS | 2178 | __metrics Screen width/height:1600/1200 17:12:03 INFO - PROCESS | 2178 | colorDepth:24 17:12:03 INFO - PROCESS | 2178 | Browser inner width/height: 1024/689 17:12:03 INFO - PROCESS | 2178 | __metrics 17:12:03 INFO - PROCESS | 2178 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:12:03 INFO - PROCESS | 2178 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:12:04 INFO - TEST-INFO | 2178: exit 0 17:12:04 INFO - Browser initialized. 17:12:04 INFO - Running cycle 1/1 for dromaeo_css test... 17:12:04 INFO - TEST-INFO | started process 2181 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/tmp3x1w3j/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:12:16 INFO - PROCESS | 2181 | RSS: Main: 168419328 17:12:16 INFO - PROCESS | 2181 | 17:13:07 INFO - PROCESS | 2181 | 1479949987613 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] 17:15:19 INFO - PROCESS | 2181 | Cycle 1(1): loaded http://localhost:54525/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54525/tests/dromaeo/cssquery-ext.html) 17:15:20 INFO - PROCESS | 2181 | RSS: Main: 320200704 17:15:20 INFO - PROCESS | 2181 | 17:18:23 INFO - PROCESS | 2181 | Cycle 1(1): loaded http://localhost:54525/tests/dromaeo/cssquery-ext.html (next: http://localhost:54525/tests/dromaeo/cssquery-jquery.html) 17:18:24 INFO - PROCESS | 2181 | RSS: Main: 301518848 17:18:24 INFO - PROCESS | 2181 | 17:21:26 INFO - PROCESS | 2181 | Cycle 1(1): loaded http://localhost:54525/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54525/tests/dromaeo/cssquery-mootools.html) 17:21:26 INFO - PROCESS | 2181 | RSS: Main: 296185856 17:21:26 INFO - PROCESS | 2181 | 17:24:29 INFO - PROCESS | 2181 | Cycle 1(1): loaded http://localhost:54525/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54525/tests/dromaeo/cssquery-prototype.html) 17:24:29 INFO - PROCESS | 2181 | RSS: Main: 268767232 17:24:29 INFO - PROCESS | 2181 | 17:27:32 INFO - PROCESS | 2181 | Cycle 1(1): loaded http://localhost:54525/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54525/tests/dromaeo/cssquery-yui.html) 17:27:33 INFO - PROCESS | 2181 | RSS: Main: 257261568 17:27:33 INFO - PROCESS | 2181 | 17:30:36 INFO - PROCESS | 2181 | Cycle 1(1): loaded http://localhost:54525/tests/dromaeo/cssquery-yui.html (next: http://localhost:54525/tests/dromaeo/cssquery-dojo.html) 17:30:36 INFO - PROCESS | 2181 | RSS: Main: 401346560 17:30:36 INFO - PROCESS | 2181 | 17:30:36 INFO - PROCESS | 2181 | __start_tp_report 17:30:36 INFO - PROCESS | 2181 | _x_x_mozilla_page_load 17:30:36 INFO - PROCESS | 2181 | _x_x_mozilla_page_load_details 17:30:36 INFO - PROCESS | 2181 | |i|pagename|runs| 17:30:36 INFO - PROCESS | 2181 | |0;dojo.html;3445.8277086145686;3460.7750496217727;3464.8614055437783;3468.861245550178;3484.7106570568894;5769.624974376663;5844.152597873316;5847.736851841667;5864.149698293755;5868.354481007091;5856.443637854397;5938.910916336258;5947.524198064155;5958.970205148979;5961.284645842494;5267.841964741055;5298.1522956327;5316.088372116213;5370.060239458098;5423.755930983096;5240.44975277596;5282.498162674559;5397.27136836526;5405.621606487547;5423.511883930445;5253.159494480884;5281.313429254211;5309.787608495675;5315.468453154692;5329.360476742777;4455.8217671293105;5306.70813105279;5323.441038690959;5411.18832175173;5414.214938833847;5224.425313215544;5312.3093997780425;5322;5326.813561525367;5390.568754499631;5694.2312787773535;5698.17376480408;5752.827415177551;5753.280839895013;5758.3665796762325;6191.969040154815;6251.468625166866;6270.3416141305415;6274.466670333027;6284.24589049317;5502.9174562381595;6270.749170033193;6278.121063051177;6290.308066112724;6292.33930437302;5791.594588378857;5865.765369385262;5870.970645146747;5961.701914904237;5994.580379373446;6327.778527751507;6337.493000559944;6356.523260755462;6361.745530178833;6366.140571022946;6230.844228894223;6238.65687387189;6240.563160578807;6253.062040693932;6253.218347706536;6203.689815509207;6235.968820155961;6253.53098517613;6266.968665156645;6284.874302513924;6211.09939058843;6248.4376406123665;6249;6261.060840873814;6269.843253918689;6195.845103872439;6241.469475094577;6255.061740738925;6260.7495700171485;6267.1539342189135;4966.701997880139;5083.669561478492;5092.363454568179;5093.643444958891;5114.28400023997;4195.328747400462;4375.518692943773;4539.205639013159;4598.747068911242;4630.328602352707;5774.913376299359;5825.854353641193;5877.118432235199;5911.9113213301835;5922.881542369215;6249.813073863287;6283.842903927347;6285.120083188357;6287.308396076428;6311.179546658905;5711.3146422428745;5785.0454674979;5873.853153671193;5911.822645320647;5913.733881975321;5467.781288748485;5506.834794956158;5512.062949298629;5524.972375138099;5552.611317207757;6478.449331806755;6501.2198536175965;6501.934980650322;6510.5117116217425;6511.153550038464;6236.438720515175;6250.218722659668;6250.812475625738;6251.312355640966;6288.308286088618;6222.346653601307;6287.339829317856;6289.339619339903;6335.683215839282;6346.016367462866;6248.4064013918605;6251.499880009497;6258.061290806416;6258.092576576462;6261.624302541862;6226.097215903759;6248.12526246335;6269.090981807703;6274.937250627435;6281.654509001866;6023.367546407564;6131.877362452815;6143.573288551087;6158;6238.532110091671;6251;6262.530310226843;6281.59169653971;6283.937160628335;6287.748490060347;6143.293521245114;6147.354527774519;6156.753729850756;6157.630542167484;6170.136180934583;6123.510119190365;6150.784722534869;6160.383961603804;6232.25212974446;6286.622802631857;6052.6973651316375;6125.235451818428;6165.167702360124;6168.722407491584;6176.474999624902 17:30:36 INFO - PROCESS | 2181 | |1;ext.html;487.91705410080294;501.7742016092757;532.9040772660921;542.7937383794158;546.855083402898;32129.19677008073;34133.65866341339;43424.6972590822;43597.47408840691;45693.54306456934;43986.68039958798;44399;44493.55506444935;44518;44637.77681111598;9915.305928585001;10104.090631843133;10121.645742399018;10122.493875306242;10122.544485498134;9411.717648470556;9658.275629327793;12345.753084938297;12615.116941814076;12631.49474021038;12530.937345313261;12606.68483287916;12627.305498197595;12640;12641;12514.3742812859;12544.937275313656;12610.936945315307;12621.621351359474;12636.431360588796;12419.068569857207;12467.94022508088;12496.25022498653;12503.812442813365;12510.74978500434;42628.57371426277;42907.7854610725;42979;42979.92550186239;42992.35511467331;3409.3692666856464;3502.702270307027;3542.6280240574624;3661.505696730934;3713.2016616427327;32825.68697252107;32897;32978.83510582456;33031.843885464135;34102.80640177607;3286.8685252589867;3303.8013137515777;3400.3199360128074;3455.3434847378917;3493.0917961329983;409116;410569;411633;411993.94003030093;412955;64270.35729642644;64630.03054954179;64692;64758.704825903216;64768;35943.92168234957;36531.452028219595;36881.07797305089;68633.65683171552;68978.62042759117;18033.00818454971;18211.089445527672;18226.544336391697;18230.817691823177;18234.36179733703;11562.826557601642;12745.49018039268;12933.676658083623;13748.450061997408;13772.655683607789;17374.98510545336;20016.59966800656;20367.388978330673;20472.385828425173;20986.895065524575;6778.356440988018;7379.631018449056;7520.022397088453;7984.321332686671;8002.759917202493;738.5716284554945;922.6586163119689;984.8916619171886;1050.3592808386877;1092.5083712329483;25093.498130037297;26943.922243110057;31239.68760312368;31258.687413126034;31376.660725252248;974.770928831724;1055.894410558938;1089.1559041742555;1097.7879572661095;1164.1152723929706;16319.02390885035;16450.424235151713;16458.83541164597;16495.34018639265;16679.91660041692;737811;739247;741625;743534;744338;62070.68964655148;62276.37723622796;62559.37440625535;62631;62641.68679156666;1305.6213698027466;1337.3781191745884;1338.6452590063836;1412.0680350968312;1439.8272207335187;27556;33751.83124084364;33866.322673546885;33958;34367.82816085903;58720.11919821292;59422.70288648702;59589.70205148947;59637.10544341925;59639.701801490715;641630;648711;649505;650633;651639;27630.723692762815;27690.307742306602;28378.716212838433;28423.85788071129;29019.854900726205;49626;49663.758406040135;49800.75099624479;50130.248046278604;50274.245886311;39884.601153988086;40598.37606495707;40765.796171018956;41363.7931810339;42731.572684274004;32880.83559582283;40271.3959290605;40413;41568.792156039024;41974;39033.609663903;39593;40142.79928600455;40175;40376.39435408413;34067;35783.10542236465;36678.63321366752;36710;36755.61088529237;22255.666165007213;24924.750752492968;26866.731332686424;26925;27327.853790569054 17:30:36 INFO - PROCESS | 2181 | |2;jquery.html;366.38264524276593;373.4062840084266;385.212240967222;388.59391935427465;410.05277808262895;19887.403377898667;20894.89552552235;21245.93770311482;21379.893100534515;21676.458088547795;11952.7609447811;12390.442430090645;12403.13178077535;13175.80236296454;21767.129314827427;5488.451154884509;5709.74306156224;5713.085906255;5716.114002329646;5716.514096301819;5575.972120139394;6231.875362492748;6286.465650419697;6302.716377763011;6303.873922521547;6029.969850150765;6272.937270627303;6278.4035516625845;6284.277308109557;6305.274893387251;6201.16284301618;6254.6872656366995;6288.654124023177;6293.9999999999545;6328.778492752755;5397.8380648580605;5570.2480165177585;5584.1902924076185;5653.971730141364;5721.628094173865;13409.86590134096;13665.111767735065;13679.931600342034;17515.649687006317;26730.465390692272;2221.9000144993515;2322.779335963081;2543.8473691578565;2713.6200931869553;2892.5805758164947;9936.552855121538;10548.261621686484;10558;13005.479780808757;14931.477398291116;1840.68708319586;1919.7312376267334;1961.4900125967208;1992.5118346005177;1992.621401933628;129080.3545982264;135806.6419335804;137108;139003.30498347443;140731.59268407288;11383.43082845871;11426.200165988468;11655.708607284885;11835.644930652094;12026.338551379584;13416.932915335556;15382.692346153015;15398.230088495531;15402.460913868184;15408.845911540966;9059.909400906039;9133.588988495401;9164.587593558306;9203.837098281898;9279.350445468752;9197.954010229905;9219.17027467531;9254.676086336945;9377.718668439958;9389.90610093904;4561.498235194193;4615.538446155358;4623.976880115578;4691.483936766953;4694.694844835075;1708.7522309265335;1719.2263481433406;1879.6616609010237;1928.9807101929082;1954.9609007819763;872.4983134697575;896.7758060484879;925.2551695884742;925.9861102083474;969.8254314223367;19052;20036.098375573136;21276.76589959421;22487.775122248895;22609;780.8867714181412;986.2110311750571;986.8865080515833;1012.4684540616088;1013.503383342157;11024.724381890517;11462;11719.238249513754;11723.179377443668;11769.352685602375;630876;641926;645607.7719611372;653955;657098;92215;114662;127676.36161819131;129829;139399;997.3417544420647;1000.394761169482;1059.2955684469896;1066.2642776484201;1071.6570697376765;18873.90563047176;19822;19889.701654474906;20553.177872884917;20583.69124463104;55200.09455612691;59045.70477147587;61078.69460652668;61644;62189.378106218355;82681.17318826975;85682;85775.57112214399;86503.70244446212;87341;6775.525713200029;7962.163972782774;8254;8440.704575339834;8681.522516261666;10583.894161058599;13176.275304858325;13408.463661453432;13599.59201223965;13635.727285454434;10772.084372828398;10983;11319.773604527698;11461.942690286494;11718.824217636571;9400.388974716621;10349.482525873525;10598.788024239318;10627.468626568796;11908.285502869856;10119.241056920613;11074.723131921766;11858.940705296418;12191.329476878856;12301.077419193418;8335.916640833757;8576.228139467477;8600.78498037554;8637.049924508174;8725.127487251224;5650.830475085754;6733.898991515229;9436.858447123435;9634.506651469033;12051.75896482083 17:30:36 INFO - PROCESS | 2181 | |3;mootools.html;1569.121292076437;1583.6278474558476;1819.7179437187233;1915.4636701723523;1964.3419454482748;8709.390342676015;9277.304202184838;9277.396969196998;9280.489573073479;9297.535123243844;8111.91888081119;8376.246137847593;8902.332325075613;8956.686515971942;9145.542722863847;2444.584420648494;2465.48224872776;2466.272449627364;2466.580681284186;2466.9136580219697;2415.4082249848725;2481.1564068216803;2485.2420011896365;2485.291691867809;2488.9004439822384;2436.3909022744315;2449.363165576954;2465.1125594785863;2470.974545563589;2471.0609968212143;2155.6766485027215;2403.7716416940452;2439.243834411338;2456.754324567547;2469.123461171276;2431.756824317572;2437.4759426723163;2438.7073551173794;2439.4633180700216;2443.2059580636187;9297.907020929772;9314;9426.245900327956;9436.905630943671;9443.763905902339;5491;5669.206311116447;5672.092465205547;5675.091985282376;5686.601937864351;3255.7069863712145;3429.9485507717404;3627.966029681528;3660.7843137254904;3866.5940076292145;1087.906653812913;1112.3659514076899;1117.1286396610656;1143.365432185137;1173.8767429419959;12400.379981000913;12471.189372690746;12492.375381230993;12492.562760303346;12521.123521353418;4771.069641419959;4786.928196077061;4839.951600484021;4981.501849814989;5002.199648056294;10568.682939511827;10573.154147668169;10576.36541807494;10587;10597.682069537927;5680.261565996394;5682.886342273131;5684.63049901755;5686.545076393962;5693.601447898607;4621.537846215351;4770.785314660849;4829.396325459317;5125.308083408692;5191.610629202825;4089.284375234322;4116.176764647083;4182.414461975326;4214.578542145761;4222.345536441856;1314.723907979316;1323.966900827487;1328.8206092177431;1335.786274196124;1338.9933050334687;880.0586045774896;955.8566215067657;959.7024922274118;972.4505654305295;983.4443539400216;4928.334674818925;5878.941210587925;5901.439363260483;6030.668313242726;6063.393660633989;432.67116991087;438.2265301742427;448.9842855500107;449.5190146543167;454.856720133157;4057.472528571267;4057.878263652095;4115.9176816464105;4120;4185.24665560196;10786.78426431467;11349.262297950607;11365.602203922823;11379.886201138048;11404;11235.325880447199;11243.718907027389;11277.605283815026;11310.09519238459;11344.829827552594;8156.877646835303;8511.787205319793;8552.529610871461;8602.225799678059;8654.524001179869;6146.907796383147;6149.323574406722;6250.874982500415;6293.496520278275;6365.96817015912;10465.162786977176;10486.318389304672;10736.30214036085;10743.46282685847;10774.461276935965;10665.986731260518;10916.50875710579;10920.836187457353;10929.83605245906;10938.289011214245;6860.313968603299;7101.396381307647;7341.302576255247;7485.326320631169;7599.924000760143;8627.137286271323;8957.417767845069;8959.552022398984;8969.416987895765;8976.371653984159;7816;7924.445288829726;7968.561729104955;8080.191980801873;8099.433039687166;7710.344620707303;7841.255080767318;7847.411444141598;7882.881756773539;7900.012498437695;7332.0834895638045;7433.516821406592;7444;7445.590492522963;7451.44114191427;5050.621203409833;5089.440161582297;5147.768350424165;5264.499872512105;5423.945760542344;5191.351081114861;5228.738563071755;5335.306410166653;5421.728913554385;5495.670259784426 17:30:36 INFO - PROCESS | 2181 | |4;prototype.html;266.5508617978706;311.45495383079594;317.8953137845985;321.9806811591303;325.21460672475973;5364.892702145955;5382.2195781611645;5446.155845843896;5466.398696143431;5488.615796894219;5050.015247026831;5140.871478213046;5243.554297884684;5363.141897296433;5365.946340536593;3401.9489707654407;4098.323776576869;4117.6705863531;4123.092919557693;4193.832246710128;3629.800360980145;3972.9868883434683;4132.214879172948;4155.709100362976;4161.583841615845;3370.629230784624;3429.657034296563;3822.10180607557;4089.1208390196102;4172.123853990651;4028.697847661437;4065.4308396824467;4071.7353372030725;4077.7145599808027;4087.9591204087874;3133.4516459619704;3517.3492903812876;3520.4543295789194;3520.8591656333715;3524.54180956474;5093.847184584469;5182.870428239286;5264.7367631618645;5270.472952704698;5342.813001544966;3825.9426108608395;4080.2451546464;4459.9038451927545;4663.323818046399;4720.43354797423;5645.165321270603;5658.265544740451;5708.229389032469;5751.626144300607;5753.252077229933;3589.2283159120916;3885.7279990400684;3899.3566061599804;3922.293987082324;3927.7446965947124;5812.534997200214;5985.34161242263;6003.399660034005;6003.699815009276;6022.367651396584;3924.17592305619;3944.152007318383;3953.9802300988313;3957.604239576019;3979.164375481181;4006.419069234945;4018.3771515415156;4027.7784721839994;4032.91934161321;4051.131169732898;4248.426462427595;4355.1725172217175;4401.657494464155;4656.3946686930485;4677.3516657007585;4909.705417674951;5652.830415087554;5673.248474489869;5685.971570142206;5705.5150312223095;1088.3524303039678;1158.3281696615943;1254.680056585583;1340.4303171152221;1365.5834970333945;782.9782134314773;841.7011960753966;889.4218757807477;894.8478758611052;912.2975309012156;5284.524392804666;5295.040834891038;5298.841034768963;5314.707691077027;5333.253344531769;5409.350877894678;5539.316354624129;5848.567101060267;5878.882422351529;5890.469857712741;4324.848630297987;4672.415948006499;5209.843704688866;5257.921131183035;5292.311999440125;2588.974110258911;2775.2506823158037;2777.750002499785;2823.0683874321426;2987.671356150822;5001.974990125026;5546.889062218733;5672.602917795714;5908.468237858613;6073;5939.287285525678;5950.626289677084;5953.553483488756;5996.910046349309;5999.710062336619;6003.418530032128;6034.818955431344;6071.453569178619;6074.939250607437;6179.969100154381;5547.977716155755;5749.655020698771;5790.205036438718;5802.187693722798;5842.970785146217;5729.28383952006;5788.986927287792;5796.971015144897;5800.7099645018425;5806.390329015392;5794.942050579441;5969.492593129633;6004.369541198112;6072.787452439144;6092.147099406176;3351.5140304656175;3882.3594106973164;3896.454496370454;3897.7661340319673;3897.9805100974313;5513.003072772208;5770.5095066919785;5819.690569621801;5846.766129354778;5889.293284805851;4746.792741375277;5140.897182056413;5236.711980841091;5614.726035955445;5731.627444216113;4922.827701030446;5107.438181799925;5620.494155526022;5680.886382272414;5713.342965559014;4567.360569520336;4621.60716339115;5279.340082489689;5425.457454254543;5575.386707462095;5709.9714501427225;5762.481376676119;5785.161151633074;5797.9420205797405;5807.767689292381;4487.573680500347;4871.902561948812;4956.330895329084;5609.943900560942;5692.48767610917 17:30:36 INFO - PROCESS | 2181 | |5;yui.html;664.5547483186265;744.3970383988969;792.3621484704814;794.2891112454354;828.860317064037;15914.522564323075;17008.659826803458;17027.148642567867;17035.744463833053;17055.91472042638;16245.593860153473;16779.748303775454;16841.83158168418;17459.563510912234;17521.824781752177;723.6273319240595;726.4116065986541;748.6780684305746;869.6086760957563;883.1609970527992;889.3374436045156;897.0984160918268;897.1566727276339;897.8024834536424;899.6806133822497;946.129560804062;949.2026697574037;949.4445749236705;950.0689324462031;950.3917492804611;943.6932996776076;945.4043952310001;945.4185675809397;946.8863736351682;947.2374738335637;699.6781480518968;700.0619170311755;700.1213477086225;700.4956431369405;701.6842420910559;16183.948043377142;16331.34674613014;16348.346066157339;16393.6721265574;16412.343506259735;14295.714085718331;14705.117692938458;14776.630584235372;14932;15067;12209.633710988684;12379.133460657758;12437.564685236064;12605.495780168781;13064.477420903248;3904.609539046101;3965.643092121694;4002.519697636302;4039.4546736190828;4113.095119073829;95488.9999999993;124365;125848.48303033887;129288;131874;11237.21339506243;11465.140114491447;11750.471228794724;11799.52801887932;12206.389680516117;23065.7693423067;23377.298681039596;23575.939082740973;23744.287671369886;23768.405789855045;8240.793980150544;8277.8344433111;8291.792705182419;8402.747917562483;8430.831383372299;4508.391367165456;4563.954360456353;4678.929816052762;4751.073540659539;4825.855224343275;3715.2198038412234;3805.4101614249835;3844.384898416296;3847.5382954045695;3867.16855875988;695.8469136789898;731.8426538294292;733.8495608400265;740.1636151149274;745.9030326057687;596.6092209602717;685.4447897203281;698.7728988078894;701.1621112770191;733.3033618062755;8980.595873185592;9649.951750241204;10303.330283531546;10347.4308913009;10381.429021403745;559.6166625861298;648.6237981970446;680.5440354962187;682.7303215229956;719.1226703421817;4715.552022557851;4860.246661767432;4860.95139048605;4952.90094198114;4970.353853998957;115490.8450915497;134275;138516;150746;172173;126983.36508317584;129667;129943.05085423538;131959.68040319666;132350;93518;106084;108187;113956.72086558222;117088;10021.549030293509;10108.797824043331;10471.842922356018;10571.682849514527;10593.89406105929;58825.70587147037;61664.766704664755;62738;63215;63401.68299158659;72856.9071463918;76400.61799690966;85228;90806.54596726975;93380;13172.538961136313;13656.93171534136;13974.091684040504;14156.009079364345;14246.287685615885;15147.772783408038;15417.845821541641;16338.836611634208;16450.75323870119;17107.828921710625;13479.865201348253;14791.704165916406;14959.77560336574;15254.389824406899;15289.159096249814;14327.068740531831;14982.700345993237;14991;15610.375584976928;15648.92175539115;14787.260636967894;15081.698366032399;15252.771208432105;15415;15460.9226953869;11365.54537818478;11746;11899.226550274205;11928.582499612472;12275.386230688608;11961.880381196077;12066.034717222778;12156.1490695654;12292.50829966827;12344.259344439362 17:30:36 INFO - PROCESS | 2181 | __end_tp_report 17:30:36 INFO - PROCESS | 2181 | __start_cc_report 17:30:36 INFO - PROCESS | 2181 | _x_x_mozilla_cycle_collect,1315 17:30:36 INFO - PROCESS | 2181 | __end_cc_report 17:30:36 INFO - PROCESS | 2181 | __startTimestamp1479951036776__endTimestamp 17:30:36 INFO - PROCESS | 2181 | 17:30:36 INFO - PROCESS | 2181 | ------- Summary: start ------- 17:30:36 INFO - PROCESS | 2181 | Number of tests: 6 17:30:36 INFO - PROCESS | 2181 | 17:30:36 INFO - PROCESS | 2181 | [#0] dojo.html Cycles:165 Average:5835.16 Median:6143.57 stddev:633.82 (10.3%) stddev-sans-first:607.42 17:30:36 INFO - PROCESS | 2181 | Values: 3445.8 3460.8 3464.9 3468.9 3484.7 5769.6 5844.2 5847.7 5864.1 5868.4 5856.4 5938.9 5947.5 5959.0 5961.3 5267.8 5298.2 5316.1 5370.1 5423.8 5240.4 5282.5 5397.3 5405.6 5423.5 5253.2 5281.3 5309.8 5315.5 5329.4 4455.8 5306.7 5323.4 5411.2 5414.2 5224.4 5312.3 5322.0 5326.8 5390.6 5694.2 5698.2 5752.8 5753.3 5758.4 6192.0 6251.5 6270.3 6274.5 6284.2 5502.9 6270.7 6278.1 6290.3 6292.3 5791.6 5865.8 5871.0 5961.7 5994.6 6327.8 6337.5 6356.5 6361.7 6366.1 6230.8 6238.7 6240.6 6253.1 6253.2 6203.7 6236.0 6253.5 6267.0 6284.9 6211.1 6248.4 6249.0 6261.1 6269.8 6195.8 6241.5 6255.1 6260.7 6267.2 4966.7 5083.7 5092.4 5093.6 5114.3 4195.3 4375.5 4539.2 4598.7 4630.3 5774.9 5825.9 5877.1 5911.9 5922.9 6249.8 6283.8 6285.1 6287.3 6311.2 5711.3 5785.0 5873.9 5911.8 5913.7 5467.8 5506.8 5512.1 5525.0 5552.6 6478.4 6501.2 6501.9 6510.5 6511.2 6236.4 6250.2 6250.8 6251.3 6288.3 6222.3 6287.3 6289.3 6335.7 6346.0 6248.4 6251.5 6258.1 6258.1 6261.6 6226.1 6248.1 6269.1 6274.9 6281.7 6023.4 6131.9 6143.6 6158.0 6238.5 6251.0 6262.5 6281.6 6283.9 6287.7 6143.3 6147.4 6156.8 6157.6 6170.1 6123.5 6150.8 6160.4 6232.3 6286.6 6052.7 6125.2 6165.2 6168.7 6176.5 17:30:36 INFO - PROCESS | 2181 | 17:30:36 INFO - PROCESS | 2181 | [#1] ext.html Cycles:180 Average:74002.57 Median:35863.51 stddev:165181.14 (460.6%) stddev-sans-first:165552.30 17:30:36 INFO - PROCESS | 2181 | Values: 487.9 501.8 532.9 542.8 546.9 32129.2 34133.7 43424.7 43597.5 45693.5 43986.7 44399.0 44493.6 44518.0 44637.8 9915.3 10104.1 10121.6 10122.5 10122.5 9411.7 9658.3 12345.8 12615.1 12631.5 12530.9 12606.7 12627.3 12640.0 12641.0 12514.4 12544.9 12610.9 12621.6 12636.4 12419.1 12467.9 12496.3 12503.8 12510.7 42628.6 42907.8 42979.0 42979.9 42992.4 3409.4 3502.7 3542.6 3661.5 3713.2 32825.7 32897.0 32978.8 33031.8 34102.8 3286.9 3303.8 3400.3 3455.3 3493.1 409116.0 410569.0 411633.0 411993.9 412955.0 64270.4 64630.0 64692.0 64758.7 64768.0 35943.9 36531.5 36881.1 68633.7 68978.6 18033.0 18211.1 18226.5 18230.8 18234.4 11562.8 12745.5 12933.7 13748.5 13772.7 17375.0 20016.6 20367.4 20472.4 20986.9 6778.4 7379.6 7520.0 7984.3 8002.8 738.6 922.7 984.9 1050.4 1092.5 25093.5 26943.9 31239.7 31258.7 31376.7 974.8 1055.9 1089.2 1097.8 1164.1 16319.0 16450.4 16458.8 16495.3 16679.9 737811.0 739247.0 741625.0 743534.0 744338.0 62070.7 62276.4 62559.4 62631.0 62641.7 1305.6 1337.4 1338.6 1412.1 1439.8 27556.0 33751.8 33866.3 33958.0 34367.8 58720.1 59422.7 59589.7 59637.1 59639.7 641630.0 648711.0 649505.0 650633.0 651639.0 27630.7 27690.3 28378.7 28423.9 29019.9 49626.0 49663.8 49800.8 50130.2 50274.2 39884.6 40598.4 40765.8 41363.8 42731.6 32880.8 40271.4 40413.0 41568.8 41974.0 39033.6 39593.0 40142.8 40175.0 40376.4 34067.0 35783.1 36678.6 36710.0 36755.6 22255.7 24924.8 26866.7 26925.0 27327.9 17:30:36 INFO - PROCESS | 2181 | 17:30:36 INFO - PROCESS | 2181 | [#2] jquery.html Cycles:180 Average:36831.87 Median:14637.16 stddev:107848.74 (736.8%) stddev-sans-first:108116.52 17:30:36 INFO - PROCESS | 2181 | Values: 366.4 373.4 385.2 388.6 410.1 19887.4 20894.9 21245.9 21379.9 21676.5 11952.8 12390.4 12403.1 13175.8 21767.1 5488.5 5709.7 5713.1 5716.1 5716.5 5576.0 6231.9 6286.5 6302.7 6303.9 6030.0 6272.9 6278.4 6284.3 6305.3 6201.2 6254.7 6288.7 6294.0 6328.8 5397.8 5570.2 5584.2 5654.0 5721.6 13409.9 13665.1 13679.9 17515.6 26730.5 2221.9 2322.8 2543.8 2713.6 2892.6 9936.6 10548.3 10558.0 13005.5 14931.5 1840.7 1919.7 1961.5 1992.5 1992.6 129080.4 135806.6 137108.0 139003.3 140731.6 11383.4 11426.2 11655.7 11835.6 12026.3 13416.9 15382.7 15398.2 15402.5 15408.8 9059.9 9133.6 9164.6 9203.8 9279.4 9198.0 9219.2 9254.7 9377.7 9389.9 4561.5 4615.5 4624.0 4691.5 4694.7 1708.8 1719.2 1879.7 1929.0 1955.0 872.5 896.8 925.3 926.0 969.8 19052.0 20036.1 21276.8 22487.8 22609.0 780.9 986.2 986.9 1012.5 1013.5 11024.7 11462.0 11719.2 11723.2 11769.4 630876.0 641926.0 645607.8 653955.0 657098.0 92215.0 114662.0 127676.4 129829.0 139399.0 997.3 1000.4 1059.3 1066.3 1071.7 18873.9 19822.0 19889.7 20553.2 20583.7 55200.1 59045.7 61078.7 61644.0 62189.4 82681.2 85682.0 85775.6 86503.7 87341.0 6775.5 7962.2 8254.0 8440.7 8681.5 10583.9 13176.3 13408.5 13599.6 13635.7 10772.1 10983.0 11319.8 11461.9 11718.8 9400.4 10349.5 10598.8 10627.5 11908.3 10119.2 11074.7 11858.9 12191.3 12301.1 8335.9 8576.2 8600.8 8637.0 8725.1 5650.8 6733.9 9436.9 9634.5 12051.8 17:30:36 INFO - PROCESS | 2181 | 17:30:36 INFO - PROCESS | 2181 | [#3] mootools.html Cycles:180 Average:5988.46 Median:4696.16 stddev:3419.99 (72.8%) stddev-sans-first:3413.46 17:30:36 INFO - PROCESS | 2181 | Values: 1569.1 1583.6 1819.7 1915.5 1964.3 8709.4 9277.3 9277.4 9280.5 9297.5 8111.9 8376.2 8902.3 8956.7 9145.5 2444.6 2465.5 2466.3 2466.6 2466.9 2415.4 2481.2 2485.2 2485.3 2488.9 2436.4 2449.4 2465.1 2471.0 2471.1 2155.7 2403.8 2439.2 2456.8 2469.1 2431.8 2437.5 2438.7 2439.5 2443.2 9297.9 9314.0 9426.2 9436.9 9443.8 5491.0 5669.2 5672.1 5675.1 5686.6 3255.7 3429.9 3628.0 3660.8 3866.6 1087.9 1112.4 1117.1 1143.4 1173.9 12400.4 12471.2 12492.4 12492.6 12521.1 4771.1 4786.9 4840.0 4981.5 5002.2 10568.7 10573.2 10576.4 10587.0 10597.7 5680.3 5682.9 5684.6 5686.5 5693.6 4621.5 4770.8 4829.4 5125.3 5191.6 4089.3 4116.2 4182.4 4214.6 4222.3 1314.7 1324.0 1328.8 1335.8 1339.0 880.1 955.9 959.7 972.5 983.4 4928.3 5878.9 5901.4 6030.7 6063.4 432.7 438.2 449.0 449.5 454.9 4057.5 4057.9 4115.9 4120.0 4185.2 10786.8 11349.3 11365.6 11379.9 11404.0 11235.3 11243.7 11277.6 11310.1 11344.8 8156.9 8511.8 8552.5 8602.2 8654.5 6146.9 6149.3 6250.9 6293.5 6366.0 10465.2 10486.3 10736.3 10743.5 10774.5 10666.0 10916.5 10920.8 10929.8 10938.3 6860.3 7101.4 7341.3 7485.3 7599.9 8627.1 8957.4 8959.6 8969.4 8976.4 7816.0 7924.4 7968.6 8080.2 8099.4 7710.3 7841.3 7847.4 7882.9 7900.0 7332.1 7433.5 7444.0 7445.6 7451.4 5050.6 5089.4 5147.8 5264.5 5423.9 5191.4 5228.7 5335.3 5421.7 5495.7 17:30:36 INFO - PROCESS | 2181 | 17:30:36 INFO - PROCESS | 2181 | [#4] prototype.html Cycles:180 Average:4600.94 Median:5261.33 stddev:1448.12 (27.5%) stddev-sans-first:1415.17 17:30:36 INFO - PROCESS | 2181 | Values: 266.6 311.5 317.9 322.0 325.2 5364.9 5382.2 5446.2 5466.4 5488.6 5050.0 5140.9 5243.6 5363.1 5365.9 3401.9 4098.3 4117.7 4123.1 4193.8 3629.8 3973.0 4132.2 4155.7 4161.6 3370.6 3429.7 3822.1 4089.1 4172.1 4028.7 4065.4 4071.7 4077.7 4088.0 3133.5 3517.3 3520.5 3520.9 3524.5 5093.8 5182.9 5264.7 5270.5 5342.8 3825.9 4080.2 4459.9 4663.3 4720.4 5645.2 5658.3 5708.2 5751.6 5753.3 3589.2 3885.7 3899.4 3922.3 3927.7 5812.5 5985.3 6003.4 6003.7 6022.4 3924.2 3944.2 3954.0 3957.6 3979.2 4006.4 4018.4 4027.8 4032.9 4051.1 4248.4 4355.2 4401.7 4656.4 4677.4 4909.7 5652.8 5673.2 5686.0 5705.5 1088.4 1158.3 1254.7 1340.4 1365.6 783.0 841.7 889.4 894.8 912.3 5284.5 5295.0 5298.8 5314.7 5333.3 5409.4 5539.3 5848.6 5878.9 5890.5 4324.8 4672.4 5209.8 5257.9 5292.3 2589.0 2775.3 2777.8 2823.1 2987.7 5002.0 5546.9 5672.6 5908.5 6073.0 5939.3 5950.6 5953.6 5996.9 5999.7 6003.4 6034.8 6071.5 6074.9 6180.0 5548.0 5749.7 5790.2 5802.2 5843.0 5729.3 5789.0 5797.0 5800.7 5806.4 5794.9 5969.5 6004.4 6072.8 6092.1 3351.5 3882.4 3896.5 3897.8 3898.0 5513.0 5770.5 5819.7 5846.8 5889.3 4746.8 5140.9 5236.7 5614.7 5731.6 4922.8 5107.4 5620.5 5680.9 5713.3 4567.4 4621.6 5279.3 5425.5 5575.4 5710.0 5762.5 5785.2 5797.9 5807.8 4487.6 4871.9 4956.3 5609.9 5692.5 17:30:36 INFO - PROCESS | 2181 | 17:30:36 INFO - PROCESS | 2181 | [#5] yui.html Cycles:180 Average:25332.41 Median:20293.80 stddev:39413.85 (194.2%) stddev-sans-first:39480.89 17:30:36 INFO - PROCESS | 2181 | Values: 664.6 744.4 792.4 794.3 828.9 15914.5 17008.7 17027.1 17035.7 17055.9 16245.6 16779.7 16841.8 17459.6 17521.8 723.6 726.4 748.7 869.6 883.2 889.3 897.1 897.2 897.8 899.7 946.1 949.2 949.4 950.1 950.4 943.7 945.4 945.4 946.9 947.2 699.7 700.1 700.1 700.5 701.7 16183.9 16331.3 16348.3 16393.7 16412.3 14295.7 14705.1 14776.6 14932.0 15067.0 12209.6 12379.1 12437.6 12605.5 13064.5 3904.6 3965.6 4002.5 4039.5 4113.1 95489.0 124365.0 125848.5 129288.0 131874.0 11237.2 11465.1 11750.5 11799.5 12206.4 23065.8 23377.3 23575.9 23744.3 23768.4 8240.8 8277.8 8291.8 8402.7 8430.8 4508.4 4564.0 4678.9 4751.1 4825.9 3715.2 3805.4 3844.4 3847.5 3867.2 695.8 731.8 733.8 740.2 745.9 596.6 685.4 698.8 701.2 733.3 8980.6 9650.0 10303.3 10347.4 10381.4 559.6 648.6 680.5 682.7 719.1 4715.6 4860.2 4861.0 4952.9 4970.4 115490.8 134275.0 138516.0 150746.0 172173.0 126983.4 129667.0 129943.1 131959.7 132350.0 93518.0 106084.0 108187.0 113956.7 117088.0 10021.5 10108.8 10471.8 10571.7 10593.9 58825.7 61664.8 62738.0 63215.0 63401.7 72856.9 76400.6 85228.0 90806.5 93380.0 13172.5 13656.9 13974.1 14156.0 14246.3 15147.8 15417.8 16338.8 16450.8 17107.8 13479.9 14791.7 14959.8 15254.4 15289.2 14327.1 14982.7 14991.0 15610.4 15648.9 14787.3 15081.7 15252.8 15415.0 15460.9 11365.5 11746.0 11899.2 11928.6 12275.4 11961.9 12066.0 12156.1 12292.5 12344.3 17:30:36 INFO - PROCESS | 2181 | -------- Summary: end -------- 17:30:36 INFO - PROCESS | 2181 | 17:30:37 INFO - TEST-INFO | 2181: exit 0 17:30:37 INFO - TEST-OK | dromaeo_css | took 1115932ms 17:30:37 INFO - TEST-START | kraken 17:30:37 INFO - operating with platform_type : mac_ 17:30:37 INFO - Initialising browser for kraken test... 17:30:37 INFO - TEST-INFO | started process 2185 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/tmp2mtKSV/profile http://localhost:54525/getInfo.html) 17:30:39 INFO - PROCESS | 2185 | __metrics Screen width/height:1600/1200 17:30:39 INFO - PROCESS | 2185 | colorDepth:24 17:30:39 INFO - PROCESS | 2185 | Browser inner width/height: 1024/689 17:30:39 INFO - PROCESS | 2185 | __metrics 17:30:39 INFO - PROCESS | 2185 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:30:39 INFO - PROCESS | 2185 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:30:40 INFO - TEST-INFO | 2185: exit 0 17:30:40 INFO - Browser initialized. 17:30:40 INFO - Running cycle 1/1 for kraken test... 17:30:40 INFO - TEST-INFO | started process 2187 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/tmp2mtKSV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:30:51 INFO - PROCESS | 2187 | RSS: Main: 164274176 17:30:51 INFO - PROCESS | 2187 | 17:30:54 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:54525/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54525/tests/kraken/driver.html?testName=audio-beat-detection) 17:30:55 INFO - PROCESS | 2187 | RSS: Main: 215453696 17:30:55 INFO - PROCESS | 2187 | 17:30:57 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:54525/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54525/tests/kraken/driver.html?testName=audio-dft) 17:30:58 INFO - PROCESS | 2187 | RSS: Main: 230379520 17:30:58 INFO - PROCESS | 2187 | 17:31:01 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:54525/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54525/tests/kraken/driver.html?testName=audio-fft) 17:31:02 INFO - PROCESS | 2187 | RSS: Main: 327581696 17:31:02 INFO - PROCESS | 2187 | 17:31:04 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:54525/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54525/tests/kraken/driver.html?testName=audio-oscillator) 17:31:05 INFO - PROCESS | 2187 | RSS: Main: 227352576 17:31:05 INFO - PROCESS | 2187 | 17:31:07 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:54525/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54525/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:31:07 INFO - PROCESS | 2187 | RSS: Main: 227278848 17:31:07 INFO - PROCESS | 2187 | 17:31:10 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:54525/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54525/tests/kraken/driver.html?testName=imaging-darkroom) 17:31:11 INFO - PROCESS | 2187 | RSS: Main: 265703424 17:31:11 INFO - PROCESS | 2187 | 17:31:13 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:54525/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54525/tests/kraken/driver.html?testName=imaging-desaturate) 17:31:14 INFO - PROCESS | 2187 | RSS: Main: 267460608 17:31:14 INFO - PROCESS | 2187 | 17:31:17 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:54525/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54525/tests/kraken/driver.html?testName=json-parse-financial) 17:31:18 INFO - PROCESS | 2187 | RSS: Main: 266280960 17:31:18 INFO - PROCESS | 2187 | 17:31:19 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:54525/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54525/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:31:20 INFO - PROCESS | 2187 | RSS: Main: 242208768 17:31:20 INFO - PROCESS | 2187 | 17:31:22 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:54525/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54525/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:31:22 INFO - PROCESS | 2187 | RSS: Main: 243335168 17:31:22 INFO - PROCESS | 2187 | 17:31:24 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:54525/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54525/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:31:25 INFO - PROCESS | 2187 | RSS: Main: 250556416 17:31:25 INFO - PROCESS | 2187 | 17:31:28 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:54525/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54525/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:31:29 INFO - PROCESS | 2187 | RSS: Main: 254279680 17:31:29 INFO - PROCESS | 2187 | 17:31:31 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:54525/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54525/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:31:32 INFO - PROCESS | 2187 | RSS: Main: 255107072 17:31:32 INFO - PROCESS | 2187 | 17:31:34 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:54525/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54525/tests/kraken/driver.html?testName=ai-astar) 17:31:34 INFO - PROCESS | 2187 | RSS: Main: 299077632 17:31:34 INFO - PROCESS | 2187 | 17:31:34 INFO - PROCESS | 2187 | __start_tp_report 17:31:34 INFO - PROCESS | 2187 | _x_x_mozilla_page_load 17:31:34 INFO - PROCESS | 2187 | _x_x_mozilla_page_load_details 17:31:34 INFO - PROCESS | 2187 | |i|pagename|runs| 17:31:34 INFO - PROCESS | 2187 | |0;ai-astar;103;114;115;114;113;115;114;114;113;113 17:31:34 INFO - PROCESS | 2187 | |1;audio-beat-detection;157;108;108;139;108;108;107;107;139;106 17:31:34 INFO - PROCESS | 2187 | |2;audio-dft;192;261;206;183;183;181;181;181;184;183 17:31:34 INFO - PROCESS | 2187 | |3;audio-fft;82;59;71;113;82;71;59;57;82;57 17:31:34 INFO - PROCESS | 2187 | |4;audio-oscillator;84;71;118;100;97;68;91;67;70;90 17:31:34 INFO - PROCESS | 2187 | |5;imaging-gaussian-blur;88;86;87;86;87;84;89;130;96;85 17:31:34 INFO - PROCESS | 2187 | |6;imaging-darkroom;96;100;97;96;97;97;97;96;97;96 17:31:34 INFO - PROCESS | 2187 | |7;imaging-desaturate;80;133;142;97;84;84;86;86;83;86 17:31:34 INFO - PROCESS | 2187 | |8;json-parse-financial;54;51;53;51;57;55;54;56;55;56 17:31:34 INFO - PROCESS | 2187 | |9;json-stringify-tinderbox;64;72;67;76;71;68;69;74;101;101 17:31:34 INFO - PROCESS | 2187 | |10;stanford-crypto-aes;81;83;82;81;82;82;80;88;89;97 17:31:34 INFO - PROCESS | 2187 | |11;stanford-crypto-ccm;137;136;131;139;146;148;148;138;148;134 17:31:34 INFO - PROCESS | 2187 | |12;stanford-crypto-pbkdf2;176;142;195;223;224;160;160;158;160;158 17:31:34 INFO - PROCESS | 2187 | |13;stanford-crypto-sha256-iterative;55;65;58;61;81;79;85;86;65;65 17:31:34 INFO - PROCESS | 2187 | __end_tp_report 17:31:34 INFO - PROCESS | 2187 | __start_cc_report 17:31:34 INFO - PROCESS | 2187 | _x_x_mozilla_cycle_collect,1848 17:31:34 INFO - PROCESS | 2187 | __end_cc_report 17:31:34 INFO - PROCESS | 2187 | __startTimestamp1479951094586__endTimestamp 17:31:34 INFO - PROCESS | 2187 | 17:31:34 INFO - PROCESS | 2187 | ------- Summary: start ------- 17:31:34 INFO - PROCESS | 2187 | Number of tests: 14 17:31:34 INFO - PROCESS | 2187 | 17:31:34 INFO - PROCESS | 2187 | [#0] ai-astar Cycles:10 Average:112.80 Median:114.00 stddev:3.52 (3.1%) stddev-sans-first:0.78 17:31:34 INFO - PROCESS | 2187 | Values: 103.0 114.0 115.0 114.0 113.0 115.0 114.0 114.0 113.0 113.0 17:31:34 INFO - PROCESS | 2187 | 17:31:34 INFO - PROCESS | 2187 | [#1] audio-beat-detection Cycles:10 Average:118.70 Median:108.00 stddev:18.81 (17.4%) stddev-sans-first:13.94 17:31:34 INFO - PROCESS | 2187 | Values: 157.0 108.0 108.0 139.0 108.0 108.0 107.0 107.0 139.0 106.0 17:31:34 INFO - PROCESS | 2187 | 17:31:34 INFO - PROCESS | 2187 | [#2] audio-dft Cycles:10 Average:193.50 Median:183.50 stddev:24.95 (13.6%) stddev-sans-first:26.46 17:31:34 INFO - PROCESS | 2187 | Values: 192.0 261.0 206.0 183.0 183.0 181.0 181.0 181.0 184.0 183.0 17:31:34 INFO - PROCESS | 2187 | 17:31:34 INFO - PROCESS | 2187 | [#3] audio-fft Cycles:10 Average:73.30 Median:71.00 stddev:17.49 (24.6%) stddev-sans-first:18.27 17:31:34 INFO - PROCESS | 2187 | Values: 82.0 59.0 71.0 113.0 82.0 71.0 59.0 57.0 82.0 57.0 17:31:34 INFO - PROCESS | 2187 | 17:31:34 INFO - PROCESS | 2187 | [#4] audio-oscillator Cycles:10 Average:85.60 Median:77.50 stddev:16.83 (21.7%) stddev-sans-first:17.85 17:31:34 INFO - PROCESS | 2187 | Values: 84.0 71.0 118.0 100.0 97.0 68.0 91.0 67.0 70.0 90.0 17:31:34 INFO - PROCESS | 2187 | 17:31:34 INFO - PROCESS | 2187 | [#5] imaging-gaussian-blur Cycles:10 Average:91.80 Median:87.00 stddev:13.82 (15.9%) stddev-sans-first:14.59 17:31:34 INFO - PROCESS | 2187 | Values: 88.0 86.0 87.0 86.0 87.0 84.0 89.0 130.0 96.0 85.0 17:31:34 INFO - PROCESS | 2187 | 17:31:34 INFO - PROCESS | 2187 | [#6] imaging-darkroom Cycles:10 Average:96.90 Median:97.00 stddev:1.20 (1.2%) stddev-sans-first:1.22 17:31:34 INFO - PROCESS | 2187 | Values: 96.0 100.0 97.0 96.0 97.0 97.0 97.0 96.0 97.0 96.0 17:31:34 INFO - PROCESS | 2187 | 17:31:34 INFO - PROCESS | 2187 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:85.00 stddev:22.36 (26.3%) stddev-sans-first:22.94 17:31:34 INFO - PROCESS | 2187 | Values: 80.0 133.0 142.0 97.0 84.0 84.0 86.0 86.0 83.0 86.0 17:31:34 INFO - PROCESS | 2187 | 17:31:34 INFO - PROCESS | 2187 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:55.00 stddev:2.04 (3.7%) stddev-sans-first:2.17 17:31:34 INFO - PROCESS | 2187 | Values: 54.0 51.0 53.0 51.0 57.0 55.0 54.0 56.0 55.0 56.0 17:31:34 INFO - PROCESS | 2187 | 17:31:34 INFO - PROCESS | 2187 | [#9] json-stringify-tinderbox Cycles:10 Average:76.30 Median:70.00 stddev:13.47 (19.2%) stddev-sans-first:13.53 17:31:34 INFO - PROCESS | 2187 | Values: 64.0 72.0 67.0 76.0 71.0 68.0 69.0 74.0 101.0 101.0 17:31:34 INFO - PROCESS | 2187 | 17:31:34 INFO - PROCESS | 2187 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:82.50 stddev:5.32 (6.4%) stddev-sans-first:5.49 17:31:34 INFO - PROCESS | 2187 | Values: 81.0 83.0 82.0 81.0 82.0 82.0 80.0 88.0 89.0 97.0 17:31:34 INFO - PROCESS | 2187 | 17:31:34 INFO - PROCESS | 2187 | [#11] stanford-crypto-ccm Cycles:10 Average:140.50 Median:142.50 stddev:6.43 (4.5%) stddev-sans-first:6.70 17:31:34 INFO - PROCESS | 2187 | Values: 137.0 136.0 131.0 139.0 146.0 148.0 148.0 138.0 148.0 134.0 17:31:34 INFO - PROCESS | 2187 | 17:31:34 INFO - PROCESS | 2187 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.60 Median:168.00 stddev:28.76 (17.1%) stddev-sans-first:30.50 17:31:34 INFO - PROCESS | 2187 | Values: 176.0 142.0 195.0 223.0 224.0 160.0 160.0 158.0 160.0 158.0 17:31:34 INFO - PROCESS | 2187 | 17:31:34 INFO - PROCESS | 2187 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.00 Median:72.00 stddev:11.59 (16.1%) stddev-sans-first:10.94 17:31:34 INFO - PROCESS | 2187 | Values: 55.0 65.0 58.0 61.0 81.0 79.0 85.0 86.0 65.0 65.0 17:31:34 INFO - PROCESS | 2187 | -------- Summary: end -------- 17:31:34 INFO - PROCESS | 2187 | 17:31:35 INFO - TEST-INFO | 2187: exit 0 17:31:35 INFO - TEST-OK | kraken | took 58044ms 17:31:35 INFO - SUITE-END | took 1173s 17:31:35 INFO - Completed test suite (00:19:34) 17:31:35 INFO - javascript benchmark 17:31:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3445.8277086145686, 3460.7750496217727, 3464.8614055437783, 3468.861245550178, 3484.7106570568894, 5769.624974376663, 5844.152597873316, 5847.736851841667, 5864.149698293755, 5868.354481007091, 5856.443637854397, 5938.910916336258, 5947.524198064155, 5958.970205148979, 5961.284645842494, 5267.841964741055, 5298.1522956327, 5316.088372116213, 5370.060239458098, 5423.755930983096, 5240.44975277596, 5282.498162674559, 5397.27136836526, 5405.621606487547, 5423.511883930445, 5253.159494480884, 5281.313429254211, 5309.787608495675, 5315.468453154692, 5329.360476742777, 4455.8217671293105, 5306.70813105279, 5323.441038690959, 5411.18832175173, 5414.214938833847, 5224.425313215544, 5312.3093997780425, 5322.0, 5326.813561525367, 5390.568754499631, 5694.2312787773535, 5698.17376480408, 5752.827415177551, 5753.280839895013, 5758.3665796762325, 6191.969040154815, 6251.468625166866, 6270.3416141305415, 6274.466670333027, 6284.24589049317, 5502.9174562381595, 6270.749170033193, 6278.121063051177, 6290.308066112724, 6292.33930437302, 5791.594588378857, 5865.765369385262, 5870.970645146747, 5961.701914904237, 5994.580379373446, 6327.778527751507, 6337.493000559944, 6356.523260755462, 6361.745530178833, 6366.140571022946, 6230.844228894223, 6238.65687387189, 6240.563160578807, 6253.062040693932, 6253.218347706536, 6203.689815509207, 6235.968820155961, 6253.53098517613, 6266.968665156645, 6284.874302513924, 6211.09939058843, 6248.4376406123665, 6249.0, 6261.060840873814, 6269.843253918689, 6195.845103872439, 6241.469475094577, 6255.061740738925, 6260.7495700171485, 6267.1539342189135, 4966.701997880139, 5083.669561478492, 5092.363454568179, 5093.643444958891, 5114.28400023997, 4195.328747400462, 4375.518692943773, 4539.205639013159, 4598.747068911242, 4630.328602352707, 5774.913376299359, 5825.854353641193, 5877.118432235199, 5911.9113213301835, 5922.881542369215, 6249.813073863287, 6283.842903927347, 6285.120083188357, 6287.308396076428, 6311.179546658905, 5711.3146422428745, 5785.0454674979, 5873.853153671193, 5911.822645320647, 5913.733881975321, 5467.781288748485, 5506.834794956158, 5512.062949298629, 5524.972375138099, 5552.611317207757, 6478.449331806755, 6501.2198536175965, 6501.934980650322, 6510.5117116217425, 6511.153550038464, 6236.438720515175, 6250.218722659668, 6250.812475625738, 6251.312355640966, 6288.308286088618, 6222.346653601307, 6287.339829317856, 6289.339619339903, 6335.683215839282, 6346.016367462866, 6248.4064013918605, 6251.499880009497, 6258.061290806416, 6258.092576576462, 6261.624302541862, 6226.097215903759, 6248.12526246335, 6269.090981807703, 6274.937250627435, 6281.654509001866, 6023.367546407564, 6131.877362452815, 6143.573288551087, 6158.0, 6238.532110091671, 6251.0, 6262.530310226843, 6281.59169653971, 6283.937160628335, 6287.748490060347, 6143.293521245114, 6147.354527774519, 6156.753729850756, 6157.630542167484, 6170.136180934583, 6123.510119190365, 6150.784722534869, 6160.383961603804, 6232.25212974446, 6286.622802631857, 6052.6973651316375, 6125.235451818428, 6165.167702360124, 6168.722407491584, 6176.474999624902], "value": 5795.202539320615, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [487.91705410080294, 501.7742016092757, 532.9040772660921, 542.7937383794158, 546.855083402898, 32129.19677008073, 34133.65866341339, 43424.6972590822, 43597.47408840691, 45693.54306456934, 43986.68039958798, 44399.0, 44493.55506444935, 44518.0, 44637.77681111598, 9915.305928585001, 10104.090631843133, 10121.645742399018, 10122.493875306242, 10122.544485498134, 9411.717648470556, 9658.275629327793, 12345.753084938297, 12615.116941814076, 12631.49474021038, 12530.937345313261, 12606.68483287916, 12627.305498197595, 12640.0, 12641.0, 12514.3742812859, 12544.937275313656, 12610.936945315307, 12621.621351359474, 12636.431360588796, 12419.068569857207, 12467.94022508088, 12496.25022498653, 12503.812442813365, 12510.74978500434, 42628.57371426277, 42907.7854610725, 42979.0, 42979.92550186239, 42992.35511467331, 3409.3692666856464, 3502.702270307027, 3542.6280240574624, 3661.505696730934, 3713.2016616427327, 32825.68697252107, 32897.0, 32978.83510582456, 33031.843885464135, 34102.80640177607, 3286.8685252589867, 3303.8013137515777, 3400.3199360128074, 3455.3434847378917, 3493.0917961329983, 409116.0, 410569.0, 411633.0, 411993.94003030093, 412955.0, 64270.35729642644, 64630.03054954179, 64692.0, 64758.704825903216, 64768.0, 35943.92168234957, 36531.452028219595, 36881.07797305089, 68633.65683171552, 68978.62042759117, 18033.00818454971, 18211.089445527672, 18226.544336391697, 18230.817691823177, 18234.36179733703, 11562.826557601642, 12745.49018039268, 12933.676658083623, 13748.450061997408, 13772.655683607789, 17374.98510545336, 20016.59966800656, 20367.388978330673, 20472.385828425173, 20986.895065524575, 6778.356440988018, 7379.631018449056, 7520.022397088453, 7984.321332686671, 8002.759917202493, 738.5716284554945, 922.6586163119689, 984.8916619171886, 1050.3592808386877, 1092.5083712329483, 25093.498130037297, 26943.922243110057, 31239.68760312368, 31258.687413126034, 31376.660725252248, 974.770928831724, 1055.894410558938, 1089.1559041742555, 1097.7879572661095, 1164.1152723929706, 16319.02390885035, 16450.424235151713, 16458.83541164597, 16495.34018639265, 16679.91660041692, 737811.0, 739247.0, 741625.0, 743534.0, 744338.0, 62070.68964655148, 62276.37723622796, 62559.37440625535, 62631.0, 62641.68679156666, 1305.6213698027466, 1337.3781191745884, 1338.6452590063836, 1412.0680350968312, 1439.8272207335187, 27556.0, 33751.83124084364, 33866.322673546885, 33958.0, 34367.82816085903, 58720.11919821292, 59422.70288648702, 59589.70205148947, 59637.10544341925, 59639.701801490715, 641630.0, 648711.0, 649505.0, 650633.0, 651639.0, 27630.723692762815, 27690.307742306602, 28378.716212838433, 28423.85788071129, 29019.854900726205, 49626.0, 49663.758406040135, 49800.75099624479, 50130.248046278604, 50274.245886311, 39884.601153988086, 40598.37606495707, 40765.796171018956, 41363.7931810339, 42731.572684274004, 32880.83559582283, 40271.3959290605, 40413.0, 41568.792156039024, 41974.0, 39033.609663903, 39593.0, 40142.79928600455, 40175.0, 40376.39435408413, 34067.0, 35783.10542236465, 36678.63321366752, 36710.0, 36755.61088529237, 22255.666165007213, 24924.750752492968, 26866.731332686424, 26925.0, 27327.853790569054], "value": 21192.740264281772, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.38264524276593, 373.4062840084266, 385.212240967222, 388.59391935427465, 410.05277808262895, 19887.403377898667, 20894.89552552235, 21245.93770311482, 21379.893100534515, 21676.458088547795, 11952.7609447811, 12390.442430090645, 12403.13178077535, 13175.80236296454, 21767.129314827427, 5488.451154884509, 5709.74306156224, 5713.085906255, 5716.114002329646, 5716.514096301819, 5575.972120139394, 6231.875362492748, 6286.465650419697, 6302.716377763011, 6303.873922521547, 6029.969850150765, 6272.937270627303, 6278.4035516625845, 6284.277308109557, 6305.274893387251, 6201.16284301618, 6254.6872656366995, 6288.654124023177, 6293.9999999999545, 6328.778492752755, 5397.8380648580605, 5570.2480165177585, 5584.1902924076185, 5653.971730141364, 5721.628094173865, 13409.86590134096, 13665.111767735065, 13679.931600342034, 17515.649687006317, 26730.465390692272, 2221.9000144993515, 2322.779335963081, 2543.8473691578565, 2713.6200931869553, 2892.5805758164947, 9936.552855121538, 10548.261621686484, 10558.0, 13005.479780808757, 14931.477398291116, 1840.68708319586, 1919.7312376267334, 1961.4900125967208, 1992.5118346005177, 1992.621401933628, 129080.3545982264, 135806.6419335804, 137108.0, 139003.30498347443, 140731.59268407288, 11383.43082845871, 11426.200165988468, 11655.708607284885, 11835.644930652094, 12026.338551379584, 13416.932915335556, 15382.692346153015, 15398.230088495531, 15402.460913868184, 15408.845911540966, 9059.909400906039, 9133.588988495401, 9164.587593558306, 9203.837098281898, 9279.350445468752, 9197.954010229905, 9219.17027467531, 9254.676086336945, 9377.718668439958, 9389.90610093904, 4561.498235194193, 4615.538446155358, 4623.976880115578, 4691.483936766953, 4694.694844835075, 1708.7522309265335, 1719.2263481433406, 1879.6616609010237, 1928.9807101929082, 1954.9609007819763, 872.4983134697575, 896.7758060484879, 925.2551695884742, 925.9861102083474, 969.8254314223367, 19052.0, 20036.098375573136, 21276.76589959421, 22487.775122248895, 22609.0, 780.8867714181412, 986.2110311750571, 986.8865080515833, 1012.4684540616088, 1013.503383342157, 11024.724381890517, 11462.0, 11719.238249513754, 11723.179377443668, 11769.352685602375, 630876.0, 641926.0, 645607.7719611372, 653955.0, 657098.0, 92215.0, 114662.0, 127676.36161819131, 129829.0, 139399.0, 997.3417544420647, 1000.394761169482, 1059.2955684469896, 1066.2642776484201, 1071.6570697376765, 18873.90563047176, 19822.0, 19889.701654474906, 20553.177872884917, 20583.69124463104, 55200.09455612691, 59045.70477147587, 61078.69460652668, 61644.0, 62189.378106218355, 82681.17318826975, 85682.0, 85775.57112214399, 86503.70244446212, 87341.0, 6775.525713200029, 7962.163972782774, 8254.0, 8440.704575339834, 8681.522516261666, 10583.894161058599, 13176.275304858325, 13408.463661453432, 13599.59201223965, 13635.727285454434, 10772.084372828398, 10983.0, 11319.773604527698, 11461.942690286494, 11718.824217636571, 9400.388974716621, 10349.482525873525, 10598.788024239318, 10627.468626568796, 11908.285502869856, 10119.241056920613, 11074.723131921766, 11858.940705296418, 12191.329476878856, 12301.077419193418, 8335.916640833757, 8576.228139467477, 8600.78498037554, 8637.049924508174, 8725.127487251224, 5650.830475085754, 6733.898991515229, 9436.858447123435, 9634.506651469033, 12051.75896482083], "value": 9655.959580281604, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1569.121292076437, 1583.6278474558476, 1819.7179437187233, 1915.4636701723523, 1964.3419454482748, 8709.390342676015, 9277.304202184838, 9277.396969196998, 9280.489573073479, 9297.535123243844, 8111.91888081119, 8376.246137847593, 8902.332325075613, 8956.686515971942, 9145.542722863847, 2444.584420648494, 2465.48224872776, 2466.272449627364, 2466.580681284186, 2466.9136580219697, 2415.4082249848725, 2481.1564068216803, 2485.2420011896365, 2485.291691867809, 2488.9004439822384, 2436.3909022744315, 2449.363165576954, 2465.1125594785863, 2470.974545563589, 2471.0609968212143, 2155.6766485027215, 2403.7716416940452, 2439.243834411338, 2456.754324567547, 2469.123461171276, 2431.756824317572, 2437.4759426723163, 2438.7073551173794, 2439.4633180700216, 2443.2059580636187, 9297.907020929772, 9314.0, 9426.245900327956, 9436.905630943671, 9443.763905902339, 5491.0, 5669.206311116447, 5672.092465205547, 5675.091985282376, 5686.601937864351, 3255.7069863712145, 3429.9485507717404, 3627.966029681528, 3660.7843137254904, 3866.5940076292145, 1087.906653812913, 1112.3659514076899, 1117.1286396610656, 1143.365432185137, 1173.8767429419959, 12400.379981000913, 12471.189372690746, 12492.375381230993, 12492.562760303346, 12521.123521353418, 4771.069641419959, 4786.928196077061, 4839.951600484021, 4981.501849814989, 5002.199648056294, 10568.682939511827, 10573.154147668169, 10576.36541807494, 10587.0, 10597.682069537927, 5680.261565996394, 5682.886342273131, 5684.63049901755, 5686.545076393962, 5693.601447898607, 4621.537846215351, 4770.785314660849, 4829.396325459317, 5125.308083408692, 5191.610629202825, 4089.284375234322, 4116.176764647083, 4182.414461975326, 4214.578542145761, 4222.345536441856, 1314.723907979316, 1323.966900827487, 1328.8206092177431, 1335.786274196124, 1338.9933050334687, 880.0586045774896, 955.8566215067657, 959.7024922274118, 972.4505654305295, 983.4443539400216, 4928.334674818925, 5878.941210587925, 5901.439363260483, 6030.668313242726, 6063.393660633989, 432.67116991087, 438.2265301742427, 448.9842855500107, 449.5190146543167, 454.856720133157, 4057.472528571267, 4057.878263652095, 4115.9176816464105, 4120.0, 4185.24665560196, 10786.78426431467, 11349.262297950607, 11365.602203922823, 11379.886201138048, 11404.0, 11235.325880447199, 11243.718907027389, 11277.605283815026, 11310.09519238459, 11344.829827552594, 8156.877646835303, 8511.787205319793, 8552.529610871461, 8602.225799678059, 8654.524001179869, 6146.907796383147, 6149.323574406722, 6250.874982500415, 6293.496520278275, 6365.96817015912, 10465.162786977176, 10486.318389304672, 10736.30214036085, 10743.46282685847, 10774.461276935965, 10665.986731260518, 10916.50875710579, 10920.836187457353, 10929.83605245906, 10938.289011214245, 6860.313968603299, 7101.396381307647, 7341.302576255247, 7485.326320631169, 7599.924000760143, 8627.137286271323, 8957.417767845069, 8959.552022398984, 8969.416987895765, 8976.371653984159, 7816.0, 7924.445288829726, 7968.561729104955, 8080.191980801873, 8099.433039687166, 7710.344620707303, 7841.255080767318, 7847.411444141598, 7882.881756773539, 7900.012498437695, 7332.0834895638045, 7433.516821406592, 7444.0, 7445.590492522963, 7451.44114191427, 5050.621203409833, 5089.440161582297, 5147.768350424165, 5264.499872512105, 5423.945760542344, 5191.351081114861, 5228.738563071755, 5335.306410166653, 5421.728913554385, 5495.670259784426], "value": 4709.862528318721, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [266.5508617978706, 311.45495383079594, 317.8953137845985, 321.9806811591303, 325.21460672475973, 5364.892702145955, 5382.2195781611645, 5446.155845843896, 5466.398696143431, 5488.615796894219, 5050.015247026831, 5140.871478213046, 5243.554297884684, 5363.141897296433, 5365.946340536593, 3401.9489707654407, 4098.323776576869, 4117.6705863531, 4123.092919557693, 4193.832246710128, 3629.800360980145, 3972.9868883434683, 4132.214879172948, 4155.709100362976, 4161.583841615845, 3370.629230784624, 3429.657034296563, 3822.10180607557, 4089.1208390196102, 4172.123853990651, 4028.697847661437, 4065.4308396824467, 4071.7353372030725, 4077.7145599808027, 4087.9591204087874, 3133.4516459619704, 3517.3492903812876, 3520.4543295789194, 3520.8591656333715, 3524.54180956474, 5093.847184584469, 5182.870428239286, 5264.7367631618645, 5270.472952704698, 5342.813001544966, 3825.9426108608395, 4080.2451546464, 4459.9038451927545, 4663.323818046399, 4720.43354797423, 5645.165321270603, 5658.265544740451, 5708.229389032469, 5751.626144300607, 5753.252077229933, 3589.2283159120916, 3885.7279990400684, 3899.3566061599804, 3922.293987082324, 3927.7446965947124, 5812.534997200214, 5985.34161242263, 6003.399660034005, 6003.699815009276, 6022.367651396584, 3924.17592305619, 3944.152007318383, 3953.9802300988313, 3957.604239576019, 3979.164375481181, 4006.419069234945, 4018.3771515415156, 4027.7784721839994, 4032.91934161321, 4051.131169732898, 4248.426462427595, 4355.1725172217175, 4401.657494464155, 4656.3946686930485, 4677.3516657007585, 4909.705417674951, 5652.830415087554, 5673.248474489869, 5685.971570142206, 5705.5150312223095, 1088.3524303039678, 1158.3281696615943, 1254.680056585583, 1340.4303171152221, 1365.5834970333945, 782.9782134314773, 841.7011960753966, 889.4218757807477, 894.8478758611052, 912.2975309012156, 5284.524392804666, 5295.040834891038, 5298.841034768963, 5314.707691077027, 5333.253344531769, 5409.350877894678, 5539.316354624129, 5848.567101060267, 5878.882422351529, 5890.469857712741, 4324.848630297987, 4672.415948006499, 5209.843704688866, 5257.921131183035, 5292.311999440125, 2588.974110258911, 2775.2506823158037, 2777.750002499785, 2823.0683874321426, 2987.671356150822, 5001.974990125026, 5546.889062218733, 5672.602917795714, 5908.468237858613, 6073.0, 5939.287285525678, 5950.626289677084, 5953.553483488756, 5996.910046349309, 5999.710062336619, 6003.418530032128, 6034.818955431344, 6071.453569178619, 6074.939250607437, 6179.969100154381, 5547.977716155755, 5749.655020698771, 5790.205036438718, 5802.187693722798, 5842.970785146217, 5729.28383952006, 5788.986927287792, 5796.971015144897, 5800.7099645018425, 5806.390329015392, 5794.942050579441, 5969.492593129633, 6004.369541198112, 6072.787452439144, 6092.147099406176, 3351.5140304656175, 3882.3594106973164, 3896.454496370454, 3897.7661340319673, 3897.9805100974313, 5513.003072772208, 5770.5095066919785, 5819.690569621801, 5846.766129354778, 5889.293284805851, 4746.792741375277, 5140.897182056413, 5236.711980841091, 5614.726035955445, 5731.627444216113, 4922.827701030446, 5107.438181799925, 5620.494155526022, 5680.886382272414, 5713.342965559014, 4567.360569520336, 4621.60716339115, 5279.340082489689, 5425.457454254543, 5575.386707462095, 5709.9714501427225, 5762.481376676119, 5785.161151633074, 5797.9420205797405, 5807.767689292381, 4487.573680500347, 4871.902561948812, 4956.330895329084, 5609.943900560942, 5692.48767610917], "value": 4130.359037272574, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [664.5547483186265, 744.3970383988969, 792.3621484704814, 794.2891112454354, 828.860317064037, 15914.522564323075, 17008.659826803458, 17027.148642567867, 17035.744463833053, 17055.91472042638, 16245.593860153473, 16779.748303775454, 16841.83158168418, 17459.563510912234, 17521.824781752177, 723.6273319240595, 726.4116065986541, 748.6780684305746, 869.6086760957563, 883.1609970527992, 889.3374436045156, 897.0984160918268, 897.1566727276339, 897.8024834536424, 899.6806133822497, 946.129560804062, 949.2026697574037, 949.4445749236705, 950.0689324462031, 950.3917492804611, 943.6932996776076, 945.4043952310001, 945.4185675809397, 946.8863736351682, 947.2374738335637, 699.6781480518968, 700.0619170311755, 700.1213477086225, 700.4956431369405, 701.6842420910559, 16183.948043377142, 16331.34674613014, 16348.346066157339, 16393.6721265574, 16412.343506259735, 14295.714085718331, 14705.117692938458, 14776.630584235372, 14932.0, 15067.0, 12209.633710988684, 12379.133460657758, 12437.564685236064, 12605.495780168781, 13064.477420903248, 3904.609539046101, 3965.643092121694, 4002.519697636302, 4039.4546736190828, 4113.095119073829, 95488.9999999993, 124365.0, 125848.48303033887, 129288.0, 131874.0, 11237.21339506243, 11465.140114491447, 11750.471228794724, 11799.52801887932, 12206.389680516117, 23065.7693423067, 23377.298681039596, 23575.939082740973, 23744.287671369886, 23768.405789855045, 8240.793980150544, 8277.8344433111, 8291.792705182419, 8402.747917562483, 8430.831383372299, 4508.391367165456, 4563.954360456353, 4678.929816052762, 4751.073540659539, 4825.855224343275, 3715.2198038412234, 3805.4101614249835, 3844.384898416296, 3847.5382954045695, 3867.16855875988, 695.8469136789898, 731.8426538294292, 733.8495608400265, 740.1636151149274, 745.9030326057687, 596.6092209602717, 685.4447897203281, 698.7728988078894, 701.1621112770191, 733.3033618062755, 8980.595873185592, 9649.951750241204, 10303.330283531546, 10347.4308913009, 10381.429021403745, 559.6166625861298, 648.6237981970446, 680.5440354962187, 682.7303215229956, 719.1226703421817, 4715.552022557851, 4860.246661767432, 4860.95139048605, 4952.90094198114, 4970.353853998957, 115490.8450915497, 134275.0, 138516.0, 150746.0, 172173.0, 126983.36508317584, 129667.0, 129943.05085423538, 131959.68040319666, 132350.0, 93518.0, 106084.0, 108187.0, 113956.72086558222, 117088.0, 10021.549030293509, 10108.797824043331, 10471.842922356018, 10571.682849514527, 10593.89406105929, 58825.70587147037, 61664.766704664755, 62738.0, 63215.0, 63401.68299158659, 72856.9071463918, 76400.61799690966, 85228.0, 90806.54596726975, 93380.0, 13172.538961136313, 13656.93171534136, 13974.091684040504, 14156.009079364345, 14246.287685615885, 15147.772783408038, 15417.845821541641, 16338.836611634208, 16450.75323870119, 17107.828921710625, 13479.865201348253, 14791.704165916406, 14959.77560336574, 15254.389824406899, 15289.159096249814, 14327.068740531831, 14982.700345993237, 14991.0, 15610.375584976928, 15648.92175539115, 14787.260636967894, 15081.698366032399, 15252.771208432105, 15415.0, 15460.9226953869, 11365.54537818478, 11746.0, 11899.226550274205, 11928.582499612472, 12275.386230688608, 11961.880381196077, 12066.034717222778, 12156.1490695654, 12292.50829966827, 12344.259344439362], "value": 8273.0481080581, "unit": "score"}], "name": "dromaeo_css", "value": 7587.987386072796, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 114.0, 115.0, 114.0, 113.0, 115.0, 114.0, 114.0, 113.0, 113.0], "value": 112.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 108.0, 108.0, 139.0, 108.0, 108.0, 107.0, 107.0, 139.0, 106.0], "value": 118.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [192.0, 261.0, 206.0, 183.0, 183.0, 181.0, 181.0, 181.0, 184.0, 183.0], "value": 193.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 59.0, 71.0, 113.0, 82.0, 71.0, 59.0, 57.0, 82.0, 57.0], "value": 73.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 71.0, 118.0, 100.0, 97.0, 68.0, 91.0, 67.0, 70.0, 90.0], "value": 85.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 87.0, 86.0, 87.0, 84.0, 89.0, 130.0, 96.0, 85.0], "value": 91.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 100.0, 97.0, 96.0, 97.0, 97.0, 97.0, 96.0, 97.0, 96.0], "value": 96.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 133.0, 142.0, 97.0, 84.0, 84.0, 86.0, 86.0, 83.0, 86.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 51.0, 53.0, 51.0, 57.0, 55.0, 54.0, 56.0, 55.0, 56.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 72.0, 67.0, 76.0, 71.0, 68.0, 69.0, 74.0, 101.0, 101.0], "value": 76.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 83.0, 82.0, 81.0, 82.0, 82.0, 80.0, 88.0, 89.0, 97.0], "value": 84.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 136.0, 131.0, 139.0, 146.0, 148.0, 148.0, 138.0, 148.0, 134.0], "value": 140.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 142.0, 195.0, 223.0, 224.0, 160.0, 160.0, 158.0, 160.0, 158.0], "value": 175.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 65.0, 58.0, 61.0, 81.0, 79.0, 85.0, 86.0, 65.0, 65.0], "value": 70.0, "unit": "score"}], "name": "kraken", "value": 1469.7999999999997, "alertThreshold": 2.0}]} 17:31:35 INFO - Return code: 0 17:31:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:31:35 INFO - # TBPL SUCCESS # 17:31:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:31:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:31:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:31:35 INFO - 2016-11-23 17:31:35.899 screenresolution[2191:24271] starting screenresolution argv=screenresolution get 17:31:35 INFO - 2016-11-23 17:31:35.902 screenresolution[2191:24271] Display 0: 1600x1200x32@60 17:31:35 INFO - 2016-11-23 17:31:35.908 screenresolution[2192:24274] starting screenresolution argv=screenresolution list 17:31:35 INFO - Available Modes on Display 0 17:31:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:31:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:31:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:31:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:31:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:31:36 INFO - Intel Iris: 17:31:36 INFO - Chipset Model: Intel Iris 17:31:36 INFO - Type: GPU 17:31:36 INFO - Bus: Built-In 17:31:36 INFO - VRAM (Dynamic, Max): 1536 MB 17:31:36 INFO - Vendor: Intel (0x8086) 17:31:36 INFO - Device ID: 0x0a2e 17:31:36 INFO - Revision ID: 0x0009 17:31:36 INFO - Displays: 17:31:36 INFO - Display: 17:31:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:31:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:31:36 INFO - Display Serial Number: 1600x1200 60 17:31:36 INFO - Main Display: Yes 17:31:36 INFO - Mirror: Off 17:31:36 INFO - Online: Yes 17:31:36 INFO - Rotation: Supported 17:31:36 INFO - Return code: 0 17:31:36 INFO - Running post-action listener: _resource_record_post_action 17:31:36 INFO - [mozharness: 2016-11-24 01:31:36.143994Z] Finished run-tests step (success) 17:31:36 INFO - Running post-run listener: _resource_record_post_run 17:31:36 INFO - Total resource usage - Wall time: 1197s; CPU: 53.0%; Read bytes: 1482752; Write bytes: 494661632; Read time: 9; Write time: 1560 17:31:36 INFO - TinderboxPrint: CPU usage
53.1% 17:31:36 INFO - TinderboxPrint: I/O read bytes / time
1,482,752 / 9 17:31:36 INFO - TinderboxPrint: I/O write bytes / time
494,661,632 / 1,560 17:31:36 INFO - TinderboxPrint: CPU idle
2,248.4 (46.9%) 17:31:36 INFO - TinderboxPrint: CPU system
950.9 (19.9%) 17:31:36 INFO - TinderboxPrint: CPU user
1,590.3 (33.2%) 17:31:36 INFO - TinderboxPrint: Swap in / out
196,296,704 / 0 17:31:36 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 192156160; Write bytes: 188469760; Read time: 17725; Write time: 409 17:31:36 INFO - run-tests - Wall time: 1175s; CPU: 53.0%; Read bytes: 602112; Write bytes: 294911488; Read time: 6; Write time: 1111 17:31:36 INFO - Running post-run listener: _upload_blobber_files 17:31:36 INFO - Blob upload gear active. 17:31:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:31:36 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 17:31:36 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'] 17:31:36 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 17:31:37 INFO - (blobuploader) - INFO - Open directory for files ... 17:31:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:31:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:31:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:31:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:31:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:31:37 INFO - (blobuploader) - INFO - Done attempting. 17:31:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:31:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:31:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:31:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:31:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:31:38 INFO - (blobuploader) - INFO - Done attempting. 17:31:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:31:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:31:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:31:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:31:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:31:41 INFO - (blobuploader) - INFO - Done attempting. 17:31:41 INFO - (blobuploader) - INFO - Iteration through files over. 17:31:41 INFO - Return code: 0 17:31:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:31:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:31:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9d27e25eb2eec475501b9e7c145697ae07bfb069d82d6bfb900089e27b007d109ddddd7d984e06f9bd70a9c541cfae0998d8e859bac9d0b3fd9664e7464c08bd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c09ae066aba51bcd6d6d3a249a60bccbb49cbfa2f362b007d137af5081ee3d607aca924c1c134f34a15c65a0b6bcd9db3ca0932ec38915e9065b0b8bb5b9fe1d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7c75148f05a701916772afd8dd346330d40d72135fddf0c6c779ac3abcc471835db0248c2539e9b79bc983080778c0432cd365ab95e572a0df7b3ed3b729624f"} 17:31:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:31:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:31:41 INFO - Contents: 17:31:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9d27e25eb2eec475501b9e7c145697ae07bfb069d82d6bfb900089e27b007d109ddddd7d984e06f9bd70a9c541cfae0998d8e859bac9d0b3fd9664e7464c08bd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c09ae066aba51bcd6d6d3a249a60bccbb49cbfa2f362b007d137af5081ee3d607aca924c1c134f34a15c65a0b6bcd9db3ca0932ec38915e9065b0b8bb5b9fe1d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7c75148f05a701916772afd8dd346330d40d72135fddf0c6c779ac3abcc471835db0248c2539e9b79bc983080778c0432cd365ab95e572a0df7b3ed3b729624f"} 17:31:41 INFO - Running post-run listener: copy_logs_to_upload_dir 17:31:41 INFO - Copying logs to upload dir... 17:31:41 INFO - mkdir: /builds/slave/test/build/upload/logs 17:31:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.286985 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-11-23 17:31:41.952094) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-23 17:31:41.955365) ========= 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.oKUimPGioa/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.0VejsYx8FQ/Listeners TMPDIR=/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9d27e25eb2eec475501b9e7c145697ae07bfb069d82d6bfb900089e27b007d109ddddd7d984e06f9bd70a9c541cfae0998d8e859bac9d0b3fd9664e7464c08bd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c09ae066aba51bcd6d6d3a249a60bccbb49cbfa2f362b007d137af5081ee3d607aca924c1c134f34a15c65a0b6bcd9db3ca0932ec38915e9065b0b8bb5b9fe1d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7c75148f05a701916772afd8dd346330d40d72135fddf0c6c779ac3abcc471835db0248c2539e9b79bc983080778c0432cd365ab95e572a0df7b3ed3b729624f"} build_url:https://queue.taskcluster.net/v1/task/dbA-lTQ3SumMH8itJ64e8A/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011466 build_url: 'https://queue.taskcluster.net/v1/task/dbA-lTQ3SumMH8itJ64e8A/artifacts/public/build/firefox-51.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9d27e25eb2eec475501b9e7c145697ae07bfb069d82d6bfb900089e27b007d109ddddd7d984e06f9bd70a9c541cfae0998d8e859bac9d0b3fd9664e7464c08bd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c09ae066aba51bcd6d6d3a249a60bccbb49cbfa2f362b007d137af5081ee3d607aca924c1c134f34a15c65a0b6bcd9db3ca0932ec38915e9065b0b8bb5b9fe1d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7c75148f05a701916772afd8dd346330d40d72135fddf0c6c779ac3abcc471835db0248c2539e9b79bc983080778c0432cd365ab95e572a0df7b3ed3b729624f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-23 17:31:41.990038) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 17:31:41.990346) ========= 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.oKUimPGioa/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.0VejsYx8FQ/Listeners TMPDIR=/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/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.005294 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 17:31:42.038517) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-23 17:31:42.038825) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-23 17:31:42.039118) ========= ========= Total master_lag: 0.18 =========