builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0287 starttime: 1483611635.15 results: success (0) buildid: 20170105010338 builduid: 4b20215d9c2443ed8a12cc624b3c1093 revision: 36ec7bc916d72028da0677ef1d14ef4782b6a963 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-05 02:20:35.147074) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-05 02:20:35.147508) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-05 02:20:35.147779) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-05 02:20:35.192936) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 02:20:35.193322) ========= 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.PHB5PjLgJy/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.SGrH7wtE0q/Listeners TMPDIR=/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-05 02:20:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.6M=0.001s 2017-01-05 02:20:35 (18.6 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.115178 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 02:20:35.332278) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 02:20:35.332607) ========= 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.PHB5PjLgJy/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.SGrH7wtE0q/Listeners TMPDIR=/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/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.024221 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 02:20:35.393657) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-05 02:20:35.394286) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 36ec7bc916d72028da0677ef1d14ef4782b6a963 --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 36ec7bc916d72028da0677ef1d14ef4782b6a963 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.PHB5PjLgJy/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.SGrH7wtE0q/Listeners TMPDIR=/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-05 02:20:35,494 truncating revision to first 12 chars 2017-01-05 02:20:35,495 Setting DEBUG logging. 2017-01-05 02:20:35,495 attempt 1/10 2017-01-05 02:20:35,495 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/36ec7bc916d7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-05 02:20:36,524 unpacking tar archive at: mozilla-beta-36ec7bc916d7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.316786 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-05 02:20:36.763737) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-05 02:20:36.764063) ========= script_repo_revision: 36ec7bc916d72028da0677ef1d14ef4782b6a963 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-05 02:20:36.764462) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-05 02:20:36.764723) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-05 02:20:36.811590) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-01-05 02:20:36.811991) ========= /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.PHB5PjLgJy/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.SGrH7wtE0q/Listeners TMPDIR=/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/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 02:20:36 INFO - MultiFileLogger online at 20170105 02:20:36 in /builds/slave/test 02:20:36 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 02:20:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:20:37 INFO - {'append_to_log': False, 02:20:37 INFO - 'base_work_dir': '/builds/slave/test', 02:20:37 INFO - 'blob_upload_branch': 'Mozilla-Beta', 02:20:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:20:37 INFO - 'branch': 'Mozilla-Beta', 02:20:37 INFO - 'buildbot_json_path': 'buildprops.json', 02:20:37 INFO - 'config_files': ('talos/mac_config.py',), 02:20:37 INFO - 'default_actions': ('clobber', 02:20:37 INFO - 'read-buildbot-config', 02:20:37 INFO - 'download-and-extract', 02:20:37 INFO - 'populate-webroot', 02:20:37 INFO - 'create-virtualenv', 02:20:37 INFO - 'install', 02:20:37 INFO - 'run-tests'), 02:20:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:20:37 INFO - 'download_minidump_stackwalk': True, 02:20:37 INFO - 'download_symbols': 'ondemand', 02:20:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:20:37 INFO - 'tooltool.py': '/tools/tooltool.py', 02:20:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:20:37 INFO - '/tools/misc-python/virtualenv.py')}, 02:20:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:20:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:20:37 INFO - 'installer_path': 'installer.exe', 02:20:37 INFO - 'log_level': 'info', 02:20:37 INFO - 'log_name': 'talos', 02:20:37 INFO - 'log_to_console': True, 02:20:37 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:20:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:20:37 INFO - 'opt_config_files': (), 02:20:37 INFO - 'pip_index': False, 02:20:37 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:20:37 INFO - 'cmd': ('bash', 02:20:37 INFO - '-c', 02:20:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:20:37 INFO - 'enabled': True, 02:20:37 INFO - 'halt_on_failure': False, 02:20:37 INFO - 'name': 'check_screen_resolution'},), 02:20:37 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:20:37 INFO - 'cmd': ('bash', 02:20:37 INFO - '-c', 02:20:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:20:37 INFO - 'enabled': True, 02:20:37 INFO - 'halt_on_failure': False, 02:20:37 INFO - 'name': 'check_screen_resolution'},), 02:20:37 INFO - 'run_cmd_checks_enabled': True, 02:20:37 INFO - 'sps_profile': False, 02:20:37 INFO - 'sps_profile_interval': 0, 02:20:37 INFO - 'suite': 'dromaeojs', 02:20:37 INFO - 'system_bits': '32', 02:20:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:20:37 INFO - 'title': 't-yosemite-r7-0287', 02:20:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:20:37 INFO - 'use_talos_json': True, 02:20:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:20:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:20:37 INFO - 'work_dir': 'build'} 02:20:37 INFO - [mozharness: 2017-01-05 10:20:37.007925Z] Running clobber step. 02:20:37 INFO - Running pre-action listener: _resource_record_pre_action 02:20:37 INFO - Running main action method: clobber 02:20:37 INFO - rmtree: /builds/slave/test/build 02:20:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:20:39 INFO - Running post-action listener: _resource_record_post_action 02:20:39 INFO - [mozharness: 2017-01-05 10:20:39.244529Z] Finished clobber step (success) 02:20:39 INFO - [mozharness: 2017-01-05 10:20:39.244654Z] Running read-buildbot-config step. 02:20:39 INFO - Running pre-action listener: _resource_record_pre_action 02:20:39 INFO - Running main action method: read_buildbot_config 02:20:39 INFO - Using buildbot properties: 02:20:39 INFO - { 02:20:39 INFO - "project": "", 02:20:39 INFO - "product": "firefox", 02:20:39 INFO - "script_repo_revision": "production", 02:20:39 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 02:20:39 INFO - "repository": "", 02:20:39 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 02:20:39 INFO - "buildid": "20170105010338", 02:20:39 INFO - "pgo_build": "False", 02:20:39 INFO - "basedir": "/builds/slave/test", 02:20:39 INFO - "buildnumber": 21, 02:20:39 INFO - "slavename": "t-yosemite-r7-0287", 02:20:39 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 02:20:39 INFO - "platform": "yosemite_r7", 02:20:39 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 02:20:39 INFO - "branch": "mozilla-beta", 02:20:39 INFO - "repo_path": "releases/mozilla-beta", 02:20:39 INFO - "revision": "36ec7bc916d72028da0677ef1d14ef4782b6a963", 02:20:39 INFO - "stage_platform": "macosx64", 02:20:39 INFO - "builduid": "4b20215d9c2443ed8a12cc624b3c1093", 02:20:39 INFO - "slavebuilddir": "test" 02:20:39 INFO - } 02:20:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/Fbq2a7hUTlW7PaAMin4ojQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 02:20:39 INFO - Running post-action listener: _resource_record_post_action 02:20:39 INFO - [mozharness: 2017-01-05 10:20:39.248003Z] Finished read-buildbot-config step (success) 02:20:39 INFO - [mozharness: 2017-01-05 10:20:39.248125Z] Running download-and-extract step. 02:20:39 INFO - Running pre-action listener: _resource_record_pre_action 02:20:39 INFO - Running main action method: download_and_extract 02:20:39 INFO - mkdir: /builds/slave/test/build/tests 02:20:39 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')]} 02:20:39 INFO - trying https://queue.taskcluster.net/v1/task/Fbq2a7hUTlW7PaAMin4ojQ/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 02:20:39 INFO - Downloading https://queue.taskcluster.net/v1/task/Fbq2a7hUTlW7PaAMin4ojQ/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 02:20:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Fbq2a7hUTlW7PaAMin4ojQ/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 02:20:40 INFO - Downloaded 1165 bytes. 02:20:40 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 02:20:40 INFO - Using the following test package requirements: 02:20:40 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 02:20:40 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 02:20:40 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 02:20:40 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 02:20:40 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 02:20:40 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 02:20:40 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 02:20:40 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 02:20:40 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 02:20:40 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 02:20:40 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 02:20:40 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 02:20:40 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 02:20:40 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 02:20:40 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 02:20:40 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 02:20:40 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 02:20:40 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 02:20:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Fbq2a7hUTlW7PaAMin4ojQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 02:20:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Fbq2a7hUTlW7PaAMin4ojQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 02:20:40 INFO - Fetch https://queue.taskcluster.net/v1/task/Fbq2a7hUTlW7PaAMin4ojQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 02:20:40 INFO - Expected file size: 16234477 02:20:47 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 02:20:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Fbq2a7hUTlW7PaAMin4ojQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 02:20:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Fbq2a7hUTlW7PaAMin4ojQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 02:20:47 INFO - Fetch https://queue.taskcluster.net/v1/task/Fbq2a7hUTlW7PaAMin4ojQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 02:20:48 INFO - Expected file size: 16234477 02:20:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Fbq2a7hUTlW7PaAMin4ojQ/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 02:20:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Fbq2a7hUTlW7PaAMin4ojQ/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 02:20:55 INFO - Fetch https://queue.taskcluster.net/v1/task/Fbq2a7hUTlW7PaAMin4ojQ/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 02:20:56 INFO - Expected file size: 14414089 02:20:57 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')]} 02:20:57 INFO - trying https://queue.taskcluster.net/v1/task/Fbq2a7hUTlW7PaAMin4ojQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg 02:20:57 INFO - Downloading https://queue.taskcluster.net/v1/task/Fbq2a7hUTlW7PaAMin4ojQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 02:20:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Fbq2a7hUTlW7PaAMin4ojQ/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 02:21:01 INFO - Downloaded 86097947 bytes. 02:21:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Fbq2a7hUTlW7PaAMin4ojQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg 02:21:01 INFO - mkdir: /builds/slave/test/properties 02:21:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:21:01 INFO - Writing to file /builds/slave/test/properties/build_url 02:21:01 INFO - Contents: 02:21:01 INFO - build_url:https://queue.taskcluster.net/v1/task/Fbq2a7hUTlW7PaAMin4ojQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg 02:21:02 INFO - Running post-action listener: _resource_record_post_action 02:21:02 INFO - Running post-action listener: set_extra_try_arguments 02:21:02 INFO - [mozharness: 2017-01-05 10:21:02.246164Z] Finished download-and-extract step (success) 02:21:02 INFO - [mozharness: 2017-01-05 10:21:02.246304Z] Running populate-webroot step. 02:21:02 INFO - Running pre-action listener: _resource_record_pre_action 02:21:02 INFO - Running main action method: populate_webroot 02:21:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:21:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:21:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:21:02 INFO - '--tppagecycles', 02:21:02 INFO - '7'], 02:21:02 INFO - 'tests': ['tsvgm']}}, 02:21:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:21:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:21:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:21:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:21:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:21:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:21:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:21:02 INFO - 'talos_options': ['--disable-e10s'], 02:21:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:21:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:21:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:21:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:21:02 INFO - 'talos_options': ['--disable-e10s'], 02:21:02 INFO - 'tests': ['damp', 'tps']}, 02:21:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:21:02 INFO - 'tests': ['damp', 'tps']}, 02:21:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:21:02 INFO - 'tests': ['dromaeo_dom']}, 02:21:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:21:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:21:02 INFO - 'tests': ['basic_compositor_video']}, 02:21:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:21:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:21:02 INFO - 'tests': ['a11yr', 02:21:02 INFO - 'ts_paint', 02:21:02 INFO - 'tpaint', 02:21:02 INFO - 'sessionrestore', 02:21:02 INFO - 'sessionrestore_no_auto_restore', 02:21:02 INFO - 'tabpaint']}, 02:21:02 INFO - 'other-e10s': {'tests': ['a11yr', 02:21:02 INFO - 'ts_paint', 02:21:02 INFO - 'tpaint', 02:21:02 INFO - 'sessionrestore', 02:21:02 INFO - 'sessionrestore_no_auto_restore', 02:21:02 INFO - 'tabpaint']}, 02:21:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:21:02 INFO - 'ts_paint', 02:21:02 INFO - 'tpaint', 02:21:02 INFO - 'sessionrestore', 02:21:02 INFO - 'sessionrestore_no_auto_restore', 02:21:02 INFO - 'tabpaint']}, 02:21:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:21:02 INFO - 'ts_paint', 02:21:02 INFO - 'tpaint', 02:21:02 INFO - 'sessionrestore', 02:21:02 INFO - 'sessionrestore_no_auto_restore', 02:21:02 INFO - 'tabpaint']}, 02:21:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:21:02 INFO - 'tests': ['a11yr', 02:21:02 INFO - 'ts_paint', 02:21:02 INFO - 'tpaint', 02:21:02 INFO - 'sessionrestore', 02:21:02 INFO - 'sessionrestore_no_auto_restore', 02:21:02 INFO - 'tabpaint']}, 02:21:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:21:02 INFO - 'tests': ['a11yr', 02:21:02 INFO - 'ts_paint', 02:21:02 INFO - 'tpaint', 02:21:02 INFO - 'sessionrestore', 02:21:02 INFO - 'sessionrestore_no_auto_restore', 02:21:02 INFO - 'tabpaint']}, 02:21:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:21:02 INFO - 'tests': ['tsvgx', 02:21:02 INFO - 'tsvgr_opacity', 02:21:02 INFO - 'tart', 02:21:02 INFO - 'tscrollx', 02:21:02 INFO - 'cart']}, 02:21:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:21:02 INFO - 'tsvgr_opacity', 02:21:02 INFO - 'tart', 02:21:02 INFO - 'tscrollx', 02:21:02 INFO - 'cart']}, 02:21:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:21:02 INFO - 'talos_options': ['--disable-e10s'], 02:21:02 INFO - 'tests': ['tp5o']}, 02:21:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:21:02 INFO - 'tests': ['tp5o']}, 02:21:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:21:02 INFO - 'talos_options': ['--disable-e10s', 02:21:02 INFO - '--xperf_path', 02:21:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:21:02 INFO - 'tests': ['tp5n']}, 02:21:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:21:02 INFO - 'talos_options': ['--xperf_path', 02:21:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:21:02 INFO - 'tests': ['tp5n']}}, 02:21:02 INFO - 'talos.zip': {'path': '', 02:21:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:21:02 INFO - Running post-action listener: _resource_record_post_action 02:21:02 INFO - [mozharness: 2017-01-05 10:21:02.266271Z] Finished populate-webroot step (success) 02:21:02 INFO - [mozharness: 2017-01-05 10:21:02.266378Z] Running create-virtualenv step. 02:21:02 INFO - Running pre-action listener: _resource_record_pre_action 02:21:02 INFO - Running main action method: create_virtualenv 02:21:02 INFO - Creating virtualenv /builds/slave/test/build/venv 02:21:02 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 02:21:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:21:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:21:02 INFO - Using real prefix '/tools/python27' 02:21:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:21:03 INFO - Installing distribute.............................................................................................................................................................................................done. 02:21:05 INFO - Installing pip.................done. 02:21:05 INFO - Return code: 0 02:21:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:21:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10aa5d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a9d3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7014b2d40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a871d30>, '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 0x10a6d7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a869b20>, '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.PHB5PjLgJy/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.SGrH7wtE0q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/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 02:21:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:21:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:21:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PHB5PjLgJy/Render', 02:21:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:21:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:21:05 INFO - 'HOME': '/Users/cltbld', 02:21:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:21:05 INFO - 'LOGNAME': 'cltbld', 02:21:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:05 INFO - 'MOZ_NO_REMOTE': '1', 02:21:05 INFO - 'NO_EM_RESTART': '1', 02:21:05 INFO - 'PAGER': '/bin/cat', 02:21:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:21:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:05 INFO - 'PWD': '/builds/slave/test', 02:21:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:21:05 INFO - 'SHELL': '/bin/bash', 02:21:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SGrH7wtE0q/Listeners', 02:21:05 INFO - 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/', 02:21:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:21:05 INFO - 'USER': 'cltbld', 02:21:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:21:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:21:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:05 INFO - 'XPC_FLAGS': '0x0', 02:21:05 INFO - 'XPC_SERVICE_NAME': '0', 02:21:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:21:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:06 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 02:21:06 INFO - Cleaning up... 02:21:06 INFO - Return code: 0 02:21:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:21:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10aa5d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a9d3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7014b2d40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a871d30>, '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 0x10a6d7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a869b20>, '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.PHB5PjLgJy/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.SGrH7wtE0q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/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 02:21:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:21:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:21:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PHB5PjLgJy/Render', 02:21:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:21:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:21:06 INFO - 'HOME': '/Users/cltbld', 02:21:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:21:06 INFO - 'LOGNAME': 'cltbld', 02:21:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:06 INFO - 'MOZ_NO_REMOTE': '1', 02:21:06 INFO - 'NO_EM_RESTART': '1', 02:21:06 INFO - 'PAGER': '/bin/cat', 02:21:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:21:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:06 INFO - 'PWD': '/builds/slave/test', 02:21:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:21:06 INFO - 'SHELL': '/bin/bash', 02:21:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SGrH7wtE0q/Listeners', 02:21:06 INFO - 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/', 02:21:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:21:06 INFO - 'USER': 'cltbld', 02:21:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:21:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:21:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:06 INFO - 'XPC_FLAGS': '0x0', 02:21:06 INFO - 'XPC_SERVICE_NAME': '0', 02:21:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:21:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:06 INFO - Downloading/unpacking psutil>=3.1.1 02:21:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:21:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:21:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:21:10 INFO - Installing collected packages: psutil 02:21:10 INFO - Running setup.py install for psutil 02:21:10 INFO - building 'psutil._psutil_osx' extension 02:21:10 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 02:21:10 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 02:21:10 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 02:21:10 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 02:21:10 INFO - building 'psutil._psutil_posix' extension 02:21:10 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 02:21:10 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:21:10 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:21:10 INFO - ^ 02:21:11 INFO - 1 warning generated. 02:21:11 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 02:21:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:21:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:21:11 INFO - Successfully installed psutil 02:21:11 INFO - Cleaning up... 02:21:11 INFO - Return code: 0 02:21:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:21: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')]} 02:21:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21: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')]} 02:21:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10aa5d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a9d3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7014b2d40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a871d30>, '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 0x10a6d7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a869b20>, '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.PHB5PjLgJy/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.SGrH7wtE0q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/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 02:21: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:21: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 mozsystemmonitor==0.3 02:21:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PHB5PjLgJy/Render', 02:21:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:21:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:21:11 INFO - 'HOME': '/Users/cltbld', 02:21:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:21:11 INFO - 'LOGNAME': 'cltbld', 02:21:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:11 INFO - 'MOZ_NO_REMOTE': '1', 02:21:11 INFO - 'NO_EM_RESTART': '1', 02:21:11 INFO - 'PAGER': '/bin/cat', 02:21:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:21:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:11 INFO - 'PWD': '/builds/slave/test', 02:21:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:21:11 INFO - 'SHELL': '/bin/bash', 02:21:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SGrH7wtE0q/Listeners', 02:21:11 INFO - 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/', 02:21:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:21:11 INFO - 'USER': 'cltbld', 02:21:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:21:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:21:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:11 INFO - 'XPC_FLAGS': '0x0', 02:21:11 INFO - 'XPC_SERVICE_NAME': '0', 02:21:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:21:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:21: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 02:21: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 02:21: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 02:21: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 02:21: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 02:21: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 02:21:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:21:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:21:14 INFO - Installing collected packages: mozsystemmonitor 02:21:14 INFO - Running setup.py install for mozsystemmonitor 02:21:14 INFO - Successfully installed mozsystemmonitor 02:21:14 INFO - Cleaning up... 02:21:14 INFO - Return code: 0 02:21:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:21:14 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')]} 02:21:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:14 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')]} 02:21:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:14 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 0x10aa5d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a9d3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7014b2d40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a871d30>, '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 0x10a6d7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a869b20>, '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.PHB5PjLgJy/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.SGrH7wtE0q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/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 02:21:14 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 02:21:14 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 02:21:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PHB5PjLgJy/Render', 02:21:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:21:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:21:14 INFO - 'HOME': '/Users/cltbld', 02:21:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:21:14 INFO - 'LOGNAME': 'cltbld', 02:21:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:14 INFO - 'MOZ_NO_REMOTE': '1', 02:21:14 INFO - 'NO_EM_RESTART': '1', 02:21:14 INFO - 'PAGER': '/bin/cat', 02:21:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:21:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:14 INFO - 'PWD': '/builds/slave/test', 02:21:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:21:14 INFO - 'SHELL': '/bin/bash', 02:21:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SGrH7wtE0q/Listeners', 02:21:14 INFO - 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/', 02:21:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:21:14 INFO - 'USER': 'cltbld', 02:21:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:21:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:21:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:14 INFO - 'XPC_FLAGS': '0x0', 02:21:14 INFO - 'XPC_SERVICE_NAME': '0', 02:21:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:21:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:14 INFO - Downloading/unpacking jsonschema==2.5.1 02:21:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:21:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:21:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:17 INFO - Downloading functools32-3.2.3-2.tar.gz 02:21:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:21:17 INFO - warning: no files found matching '*.txt' 02:21:17 INFO - no previously-included directories found matching 'build' 02:21:17 INFO - no previously-included directories found matching 'dist' 02:21:17 INFO - no previously-included directories found matching '.git*' 02:21:17 INFO - Installing collected packages: jsonschema, functools32 02:21:17 INFO - Running setup.py install for functools32 02:21:18 INFO - warning: no files found matching '*.txt' 02:21:18 INFO - no previously-included directories found matching 'build' 02:21:18 INFO - no previously-included directories found matching 'dist' 02:21:18 INFO - no previously-included directories found matching '.git*' 02:21:18 INFO - Successfully installed jsonschema functools32 02:21:18 INFO - Cleaning up... 02:21:18 INFO - Return code: 0 02:21:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:21:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10aa5d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a9d3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7014b2d40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a871d30>, '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 0x10a6d7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a869b20>, '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.PHB5PjLgJy/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.SGrH7wtE0q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/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 02:21:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:21:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:21:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PHB5PjLgJy/Render', 02:21:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:21:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:21:18 INFO - 'HOME': '/Users/cltbld', 02:21:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:21:18 INFO - 'LOGNAME': 'cltbld', 02:21:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:18 INFO - 'MOZ_NO_REMOTE': '1', 02:21:18 INFO - 'NO_EM_RESTART': '1', 02:21:18 INFO - 'PAGER': '/bin/cat', 02:21:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:21:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:18 INFO - 'PWD': '/builds/slave/test', 02:21:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:21:18 INFO - 'SHELL': '/bin/bash', 02:21:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SGrH7wtE0q/Listeners', 02:21:18 INFO - 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/', 02:21:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:21:18 INFO - 'USER': 'cltbld', 02:21:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:21:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:21:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:18 INFO - 'XPC_FLAGS': '0x0', 02:21:18 INFO - 'XPC_SERVICE_NAME': '0', 02:21:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:21:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:21:18 INFO - Cleaning up... 02:21:18 INFO - Return code: 0 02:21:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:21:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10aa5d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a9d3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7014b2d40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a871d30>, '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 0x10a6d7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a869b20>, '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.PHB5PjLgJy/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.SGrH7wtE0q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/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 02:21:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:21:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:21:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PHB5PjLgJy/Render', 02:21:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:21:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:21:18 INFO - 'HOME': '/Users/cltbld', 02:21:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:21:18 INFO - 'LOGNAME': 'cltbld', 02:21:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:18 INFO - 'MOZ_NO_REMOTE': '1', 02:21:18 INFO - 'NO_EM_RESTART': '1', 02:21:18 INFO - 'PAGER': '/bin/cat', 02:21:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:21:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:18 INFO - 'PWD': '/builds/slave/test', 02:21:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:21:18 INFO - 'SHELL': '/bin/bash', 02:21:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SGrH7wtE0q/Listeners', 02:21:18 INFO - 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/', 02:21:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:21:18 INFO - 'USER': 'cltbld', 02:21:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:21:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:21:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:18 INFO - 'XPC_FLAGS': '0x0', 02:21:18 INFO - 'XPC_SERVICE_NAME': '0', 02:21:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:21:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:18 INFO - Downloading/unpacking blobuploader==1.2.4 02:21:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:21 INFO - Downloading blobuploader-1.2.4.tar.gz 02:21:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:21:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:21:21 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 02:21:21 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 02:21:21 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 02:21:21 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 02:21:21 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 02:21:21 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 02:21:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:21:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:21: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 02:21: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 02:21: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 02:21: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 02:21: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 02:21: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 02:21:22 INFO - Downloading docopt-0.6.1.tar.gz 02:21:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:21:22 INFO - Installing collected packages: blobuploader, requests, docopt 02:21:22 INFO - Running setup.py install for blobuploader 02:21:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:21:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:21:22 INFO - Running setup.py install for requests 02:21:23 INFO - Running setup.py install for docopt 02:21:23 INFO - Successfully installed blobuploader requests docopt 02:21:23 INFO - Cleaning up... 02:21:23 INFO - Return code: 0 02:21:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:21: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')]} 02:21:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21: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')]} 02:21:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:23 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 0x10aa5d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a9d3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7014b2d40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a871d30>, '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 0x10a6d7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a869b20>, '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.PHB5PjLgJy/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.SGrH7wtE0q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/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 02:21:23 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 02:21:23 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 02:21:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PHB5PjLgJy/Render', 02:21:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:21:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:21:23 INFO - 'HOME': '/Users/cltbld', 02:21:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:21:23 INFO - 'LOGNAME': 'cltbld', 02:21:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:23 INFO - 'MOZ_NO_REMOTE': '1', 02:21:23 INFO - 'NO_EM_RESTART': '1', 02:21:23 INFO - 'PAGER': '/bin/cat', 02:21:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:21:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:23 INFO - 'PWD': '/builds/slave/test', 02:21:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:21:23 INFO - 'SHELL': '/bin/bash', 02:21:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SGrH7wtE0q/Listeners', 02:21:23 INFO - 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/', 02:21:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:21:23 INFO - 'USER': 'cltbld', 02:21:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:21:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:21:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:23 INFO - 'XPC_FLAGS': '0x0', 02:21:23 INFO - 'XPC_SERVICE_NAME': '0', 02:21:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:21:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:21:23 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-M5XcwK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:21:24 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-qAIfr0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:21:24 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-5dzRPV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:21:24 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-wYep5Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:21:24 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-Q9xUIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:21:24 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-fDkS54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:21:24 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-HOdNB6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:21:24 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-WmsGIC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:21:24 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-b1YVPU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:21:24 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-wxmpTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:21:24 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-dwBJtU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:21:25 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-ljOdJ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:21:25 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-H4l1fm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:21:25 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-oBtSUo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:21:25 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-XZoHr_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:21:25 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-hj151o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:21:25 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-_ZPRqD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:21:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:21:25 INFO - Running setup.py install for manifestparser 02:21:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:21:25 INFO - Running setup.py install for mozcrash 02:21:26 INFO - Running setup.py install for mozdebug 02:21:26 INFO - Running setup.py install for mozdevice 02:21:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:21:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:21:26 INFO - Running setup.py install for mozfile 02:21:26 INFO - Running setup.py install for mozhttpd 02:21:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:21:26 INFO - Running setup.py install for mozinfo 02:21:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:21:26 INFO - Running setup.py install for mozInstall 02:21:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:21:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:21:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:21:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:21:26 INFO - Running setup.py install for mozleak 02:21:27 INFO - Running setup.py install for mozlog 02:21:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:21:27 INFO - Running setup.py install for moznetwork 02:21:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:21:27 INFO - Running setup.py install for mozprocess 02:21:27 INFO - Running setup.py install for mozprofile 02:21:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:21:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:21:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:21:27 INFO - Running setup.py install for mozrunner 02:21:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:21:27 INFO - Running setup.py install for mozscreenshot 02:21:28 INFO - Running setup.py install for moztest 02:21:28 INFO - Running setup.py install for mozversion 02:21:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:21:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:21:28 INFO - Cleaning up... 02:21:28 INFO - Return code: 0 02:21:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:21:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:28 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 0x10aa5d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a9d3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7014b2d40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a871d30>, '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 0x10a6d7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a869b20>, '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.PHB5PjLgJy/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.SGrH7wtE0q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/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 02:21:28 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 02:21:28 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 02:21:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PHB5PjLgJy/Render', 02:21:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:21:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:21:28 INFO - 'HOME': '/Users/cltbld', 02:21:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:21:28 INFO - 'LOGNAME': 'cltbld', 02:21:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:28 INFO - 'MOZ_NO_REMOTE': '1', 02:21:28 INFO - 'NO_EM_RESTART': '1', 02:21:28 INFO - 'PAGER': '/bin/cat', 02:21:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:21:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:28 INFO - 'PWD': '/builds/slave/test', 02:21:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:21:28 INFO - 'SHELL': '/bin/bash', 02:21:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SGrH7wtE0q/Listeners', 02:21:28 INFO - 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/', 02:21:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:21:28 INFO - 'USER': 'cltbld', 02:21:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:21:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:21:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:28 INFO - 'XPC_FLAGS': '0x0', 02:21:28 INFO - 'XPC_SERVICE_NAME': '0', 02:21:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:21:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:21:28 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-PRCmdg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:21:28 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)) 02:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:21:28 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-zqQ47H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:21:28 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)) 02:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:21:28 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-bru552-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:21:28 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)) 02:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:21:28 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-R53aIj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:21:29 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)) 02:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:21:29 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-OIpfhT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:21:29 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)) 02:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:21:29 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-Silto7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:21:29 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)) 02:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:21:29 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-BWNpvy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:21:29 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)) 02:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:21:29 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-CC_cSE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:21:29 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)) 02:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:21:29 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-e_4Ysf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:21:29 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)) 02:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:21:29 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-F5KFTT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:21:29 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)) 02:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:21:29 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-ccl0GA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:21:29 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)) 02:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:21:29 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-xdP7M2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:21:29 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)) 02:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:21:29 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-yqfot_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:21:30 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)) 02:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:21:30 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-O6537W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:21:30 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)) 02:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:21:30 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-DsjqGM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:21:30 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)) 02:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:21:30 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-m2iEA0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:21:30 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)) 02:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:21:30 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-wja8qC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:21:30 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)) 02:21:30 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)) 02:21:30 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)) 02:21:30 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)) 02:21:30 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)) 02:21:30 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)) 02:21:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:21:30 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 02:21:30 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 02:21:30 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 02:21:30 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 02:21:30 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 02:21:30 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 02:21:32 INFO - Downloading blessings-1.6.tar.gz 02:21:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:21:33 INFO - Installing collected packages: blessings 02:21:33 INFO - Running setup.py install for blessings 02:21:33 INFO - Successfully installed blessings 02:21:33 INFO - Cleaning up... 02:21:33 INFO - Return code: 0 02:21:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:21:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:21:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:21:33 INFO - Reading from file tmpfile_stdout 02:21:33 INFO - Current package versions: 02:21:33 INFO - blessings == 1.6 02:21:33 INFO - blobuploader == 1.2.4 02:21:33 INFO - docopt == 0.6.1 02:21:33 INFO - functools32 == 3.2.3-2 02:21:33 INFO - jsonschema == 2.5.1 02:21:33 INFO - manifestparser == 1.1 02:21:33 INFO - mozInstall == 1.12 02:21:33 INFO - mozcrash == 0.17 02:21:33 INFO - mozdebug == 0.1 02:21:33 INFO - mozdevice == 0.48 02:21:33 INFO - mozfile == 1.2 02:21:33 INFO - mozhttpd == 0.7 02:21:33 INFO - mozinfo == 0.9 02:21:33 INFO - mozleak == 0.1 02:21:33 INFO - mozlog == 3.4 02:21:33 INFO - moznetwork == 0.27 02:21:33 INFO - mozprocess == 0.23 02:21:33 INFO - mozprofile == 0.28 02:21:33 INFO - mozrunner == 6.12 02:21:33 INFO - mozscreenshot == 0.1 02:21:33 INFO - mozsystemmonitor == 0.3 02:21:33 INFO - moztest == 0.7 02:21:33 INFO - mozversion == 1.4 02:21:33 INFO - psutil == 3.1.1 02:21:33 INFO - requests == 1.2.3 02:21:33 INFO - wsgiref == 0.1.2 02:21:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:21:33 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')]} 02:21:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:33 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')]} 02:21:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:33 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 0x10aa5d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a9d3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7014b2d40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a871d30>, '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 0x10a6d7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a869b20>, '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.PHB5PjLgJy/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.SGrH7wtE0q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/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 02:21:33 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 02:21:33 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 02:21:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PHB5PjLgJy/Render', 02:21:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:21:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:21:33 INFO - 'HOME': '/Users/cltbld', 02:21:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:21:33 INFO - 'LOGNAME': 'cltbld', 02:21:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:33 INFO - 'MOZ_NO_REMOTE': '1', 02:21:33 INFO - 'NO_EM_RESTART': '1', 02:21:33 INFO - 'PAGER': '/bin/cat', 02:21:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:21:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:33 INFO - 'PWD': '/builds/slave/test', 02:21:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:21:33 INFO - 'SHELL': '/bin/bash', 02:21:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SGrH7wtE0q/Listeners', 02:21:33 INFO - 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/', 02:21:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:21:33 INFO - 'USER': 'cltbld', 02:21:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:21:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:21:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:33 INFO - 'XPC_FLAGS': '0x0', 02:21:33 INFO - 'XPC_SERVICE_NAME': '0', 02:21:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:21:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:33 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)) 02:21:33 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)) 02:21:33 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)) 02:21:33 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)) 02:21:33 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)) 02:21:33 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)) 02:21:33 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)) 02:21:33 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)) 02:21:33 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)) 02:21:33 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)) 02:21:33 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)) 02:21:33 INFO - Cleaning up... 02:21:33 INFO - Return code: 0 02:21:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:21:33 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')]} 02:21:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:33 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')]} 02:21:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:33 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 0x10aa5d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a9d3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7014b2d40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a871d30>, '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 0x10a6d7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a869b20>, '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.PHB5PjLgJy/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.SGrH7wtE0q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/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 02:21:33 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 02:21:33 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 02:21:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PHB5PjLgJy/Render', 02:21:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:21:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:21:33 INFO - 'HOME': '/Users/cltbld', 02:21:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:21:33 INFO - 'LOGNAME': 'cltbld', 02:21:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:33 INFO - 'MOZ_NO_REMOTE': '1', 02:21:33 INFO - 'NO_EM_RESTART': '1', 02:21:33 INFO - 'PAGER': '/bin/cat', 02:21:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:21:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:33 INFO - 'PWD': '/builds/slave/test', 02:21:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:21:33 INFO - 'SHELL': '/bin/bash', 02:21:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SGrH7wtE0q/Listeners', 02:21:33 INFO - 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/', 02:21:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:21:33 INFO - 'USER': 'cltbld', 02:21:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:21:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:21:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:33 INFO - 'XPC_FLAGS': '0x0', 02:21:33 INFO - 'XPC_SERVICE_NAME': '0', 02:21:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:21:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:21:34 INFO - Cleaning up... 02:21:34 INFO - Return code: 0 02:21:34 INFO - Running post-action listener: _resource_record_post_action 02:21:34 INFO - Running post-action listener: _start_resource_monitoring 02:21:34 INFO - Starting resource monitoring. 02:21:34 INFO - [mozharness: 2017-01-05 10:21:34.183292Z] Finished create-virtualenv step (success) 02:21:34 INFO - [mozharness: 2017-01-05 10:21:34.184320Z] Running install step. 02:21:34 INFO - Running pre-action listener: _resource_record_pre_action 02:21:34 INFO - Running main action method: install 02:21:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:21:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:21:34 INFO - Reading from file tmpfile_stdout 02:21:34 INFO - Detecting whether we're running mozinstall >=1.0... 02:21:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:21:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:21:34 INFO - Reading from file tmpfile_stdout 02:21:34 INFO - Output received: 02:21:34 INFO - Usage: mozinstall [options] installer 02:21:34 INFO - Options: 02:21:34 INFO - -h, --help show this help message and exit 02:21:34 INFO - -d DEST, --destination=DEST 02:21:34 INFO - Directory to install application into. [default: 02:21:34 INFO - "/builds/slave/test"] 02:21:34 INFO - --app=APP Application being installed. [default: firefox] 02:21:34 INFO - mkdir: /builds/slave/test/build/application 02:21:34 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'] 02:21:34 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 02:21:56 INFO - Reading from file tmpfile_stdout 02:21:56 INFO - Output received: 02:21:56 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 02:21:56 INFO - Running post-action listener: _resource_record_post_action 02:21:56 INFO - [mozharness: 2017-01-05 10:21:56.496785Z] Finished install step (success) 02:21:56 INFO - [mozharness: 2017-01-05 10:21:56.496957Z] Running run-tests step. 02:21:56 INFO - Running pre-action listener: _resource_record_pre_action 02:21:56 INFO - Running main action method: run_tests 02:21:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:21:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:21:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:21:56 INFO - 2017-01-05 02:21:56.511 screenresolution[1632:7798] starting screenresolution argv=screenresolution get 02:21:56 INFO - 2017-01-05 02:21:56.514 screenresolution[1632:7798] Display 0: 1600x1200x32@60 02:21:56 INFO - 2017-01-05 02:21:56.519 screenresolution[1633:7800] starting screenresolution argv=screenresolution list 02:21:56 INFO - Available Modes on Display 0 02:21:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:21:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:21:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:21:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:21:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:21:56 INFO - Intel Iris: 02:21:56 INFO - Chipset Model: Intel Iris 02:21:56 INFO - Type: GPU 02:21:56 INFO - Bus: Built-In 02:21:56 INFO - VRAM (Dynamic, Max): 1536 MB 02:21:56 INFO - Vendor: Intel (0x8086) 02:21:56 INFO - Device ID: 0x0a2e 02:21:56 INFO - Revision ID: 0x0009 02:21:56 INFO - Displays: 02:21:56 INFO - Display: 02:21:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:21:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:21:56 INFO - Display Serial Number: 1600x1200 60 02:21:56 INFO - Main Display: Yes 02:21:56 INFO - Mirror: Off 02:21:56 INFO - Online: Yes 02:21:56 INFO - Rotation: Supported 02:21:56 INFO - Return code: 0 02:21:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:21:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:21:56 INFO - Python 2.7.3 02:21:56 INFO - Return code: 0 02:21:56 INFO - grabbing minidump binary from tooltool 02:21:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:21:56 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 0x10a871d30>, '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 0x10a6d7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a869b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:21:56 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 02:21:56 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 02:21:56 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 02:21:56 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:21:56 INFO - Return code: 0 02:21:56 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:21:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:21:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:21:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:21:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:21:56 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/Fbq2a7hUTlW7PaAMin4ojQ/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0287', '--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 02:21:56 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/Fbq2a7hUTlW7PaAMin4ojQ/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0287 --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 02:21:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PHB5PjLgJy/Render', 02:21:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:21:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:21:56 INFO - 'HOME': '/Users/cltbld', 02:21:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:21:56 INFO - 'LOGNAME': 'cltbld', 02:21:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:21:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:21:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:56 INFO - 'MOZ_NO_REMOTE': '1', 02:21:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:21:56 INFO - 'NO_EM_RESTART': '1', 02:21:56 INFO - 'PAGER': '/bin/cat', 02:21:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:21:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:56 INFO - 'PWD': '/builds/slave/test', 02:21:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:21:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:21:56 INFO - 'SHELL': '/bin/bash', 02:21:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SGrH7wtE0q/Listeners', 02:21:56 INFO - 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/', 02:21:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:21:56 INFO - 'USER': 'cltbld', 02:21:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:21:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:21:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:56 INFO - 'XPC_FLAGS': '0x0', 02:21:56 INFO - 'XPC_SERVICE_NAME': '0', 02:21:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:21:56 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/Fbq2a7hUTlW7PaAMin4ojQ/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0287', '--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 02:21:57 INFO - mozversion application_buildid: 20170105010338 02:21:57 INFO - mozversion application_changeset: 36ec7bc916d72028da0677ef1d14ef4782b6a963 02:21:57 INFO - mozversion application_display_name: Firefox 02:21:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:21:57 INFO - mozversion application_name: Firefox 02:21:57 INFO - mozversion application_remotingname: firefox 02:21:57 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 02:21:57 INFO - mozversion application_vendor: Mozilla 02:21:57 INFO - mozversion application_version: 51.0 02:21:57 INFO - mozversion platform_buildid: 20170105010338 02:21:57 INFO - mozversion platform_changeset: 36ec7bc916d72028da0677ef1d14ef4782b6a963 02:21:57 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 02:21:57 INFO - mozversion platform_version: 51.0 02:21:57 INFO - using testdate: 1483611717 02:21:57 INFO - actual date: 1483611717 02:21:57 INFO - starting webserver on 'localhost:49247' 02:21:57 INFO - SUITE-START | Running 2 tests 02:21:57 INFO - TEST-START | dromaeo_css 02:21:57 INFO - operating with platform_type : mac_ 02:21:57 INFO - Initialising browser for dromaeo_css test... 02:21:57 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/tmp7sa69R/profile http://localhost:49247/getInfo.html) 02:21:59 INFO - PROCESS | 1643 | __metrics Screen width/height:1600/1200 02:21:59 INFO - PROCESS | 1643 | colorDepth:24 02:21:59 INFO - PROCESS | 1643 | Browser inner width/height: 1024/689 02:21:59 INFO - PROCESS | 1643 | __metrics 02:21:59 INFO - PROCESS | 1643 | 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" 02:21:59 INFO - PROCESS | 1643 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:22:00 INFO - TEST-INFO | 1643: exit 0 02:22:00 INFO - Browser initialized. 02:22:00 INFO - Running cycle 1/1 for dromaeo_css test... 02:22:00 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/tmp7sa69R/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:22:12 INFO - PROCESS | 1646 | RSS: Main: 168509440 02:22:12 INFO - PROCESS | 1646 | 02:23:03 INFO - PROCESS | 1646 | 1483611783286 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] 02:25:13 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49247/tests/dromaeo/cssquery-ext.html) 02:25:15 INFO - PROCESS | 1646 | RSS: Main: 278081536 02:25:15 INFO - PROCESS | 1646 | 02:28:17 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-ext.html (next: http://localhost:49247/tests/dromaeo/cssquery-jquery.html) 02:28:18 INFO - PROCESS | 1646 | RSS: Main: 300523520 02:28:18 INFO - PROCESS | 1646 | 02:31:20 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49247/tests/dromaeo/cssquery-mootools.html) 02:31:21 INFO - PROCESS | 1646 | RSS: Main: 277905408 02:31:21 INFO - PROCESS | 1646 | 02:34:23 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49247/tests/dromaeo/cssquery-prototype.html) 02:34:24 INFO - PROCESS | 1646 | RSS: Main: 274223104 02:34:24 INFO - PROCESS | 1646 | 02:37:27 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49247/tests/dromaeo/cssquery-yui.html) 02:37:27 INFO - PROCESS | 1646 | RSS: Main: 265039872 02:37:27 INFO - PROCESS | 1646 | 02:40:30 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-yui.html (next: http://localhost:49247/tests/dromaeo/cssquery-dojo.html) 02:40:31 INFO - PROCESS | 1646 | RSS: Main: 418119680 02:40:31 INFO - PROCESS | 1646 | 02:40:31 INFO - PROCESS | 1646 | __start_tp_report 02:40:31 INFO - PROCESS | 1646 | _x_x_mozilla_page_load 02:40:31 INFO - PROCESS | 1646 | _x_x_mozilla_page_load_details 02:40:31 INFO - PROCESS | 1646 | |i|pagename|runs| 02:40:31 INFO - PROCESS | 1646 | |0;dojo.html;3210.486322188449;3422.0931453164912;3428.6914177724007;3487.476878468228;3515.7011654009407;5690.3171619405675;5791.07342825148;5836.2996440427105;5836.5914385993;5854.912176317359;5781.797637082703;5859.736311865966;5864.149698293755;5870.090136028923;5882.970585147079;5236.266922630825;5272.736363181844;5286.259923610678;5330.573554115662;5344.011357898782;5220.738963051851;5224.791008359661;5238.030964271622;5244.711540865251;5375.892482150354;5224.059669259551;5315.521603055724;5321.973390133063;5333.679979201261;5344.732763361836;5307.38965019022;5310.867228319285;5316.0962636351915;5322.467753224685;5365.919511207335;5148.794048238066;5184.818531351422;5195.376554813409;5275.920861187085;5276.3140791697215;5701.087825947829;5701.572382071361;5788.363280039192;5799.21710569072;5804.245448091721;6198.783042593487;6239.032949892774;6259.453865138143;6286.559940804145;6295.181626388586;6240.563160578761;6251.156093927307;6260.530460215502;6264.9686751566405;6265.592736472115;5675.659460432387;5785.334686511021;5817.854553636193;5839.591228614041;5841.4450627190345;6305.558610897285;6310.7475700971445;6332.271788744261;6334.081558174039;6335.588186767845;6230.376962303733;6240.968795155995;6250.062490626442;6252.906206406908;6257.937420625826;6164.660943648142;6179.876402471926;6219.906701399483;6246.000639897595;6253.187085678833;6156.07658851167;6174.197354343996;6181.041938499539;6181.289151747516;6197.411245931719;5200;6156.199694039746;6200.3799620038535;6211.3478084800445;6221.751129954841;4887.633427492952;4907.754612269372;4936.2102063669645;4951.603871690256;4966;4466.6873318867365;4494.07871386365;4500.909981800346;4527.0493196429115;4571.657125715585;5993.730282137227;6003.849903752441;6003.939960600338;6006.489448396936;6039.184710064085;6145.525073982301;6183.350748171467;6296.905546416808;6299.905501417391;6313.021481670348;5928.970355148197;5999.070144127667;6017.789377371771;6054.485368743706;6107.419795119546;5459.945400545944;5505.642133261325;5505.972470137704;5507.669539827623;5511.173324001432;6249.187605611241;6451.387118223761;6453.290138084807;6461.06314584392;6471.741130354733;6191.25704915413;6198.845028874314;6267.717952692231;6274.811755647338;6296.275928268308;6403.6798160090875;6407.871842563216;6422.550421470452;6433.517486188648;6455.9677201613695;6249.093881387264;6253.405926436982;6254.499640028877;6279.529035322278;6299.118123462627;6046.244219472566;6157.907631385622;6181.752729890754;6250.718717657807;6297.1813664223355;6239.532035097295;6242;6245.219347581552;6253.312135664983;6263.342349053284;6215.223097112861;6215.81352559424;6245.750169993149;6251.343608920998;6259.499240060875;5946.702664866826;6011.609245399035;6044.972354699799;6066.388391969717;6069.02895536712;6215.751369945152;6233.314335423009;6254.061890716429;6258.499320054294;6261;6112.694365281807;6114.7248373822395;6122.204113465221;6144;6151.477124444473 02:40:31 INFO - PROCESS | 1646 | |1;ext.html;470.18657722140694;497.286394024575;499.7451299837082;518.4763388977133;520.8593679706479;31052;40277.19445611086;40857.59142408579;40895.795521022425;44323;43810.342844857274;44095;44107.338389924174;44130.77934610323;44205.77897110518;9985.650502232442;10187.949060254725;10196.827364853025;10197.490125493732;10200.183985281197;9237.399569027992;9490;12296.631101066982;12526.43631036601;12598.81101783474;12300.938495307511;12326.013918886467;12437.564685236019;12530.18553794005;12552.37238138094;12436.626901192933;12522.123451358408;12528.310942898137;12545.1218414711;12549.623511294676;12248.693782655415;12303.261804291682;12332.938335308356;12348.938255308665;12355.876441235563;40804.79597601993;41087.178256435;41151;41185.970350741474;41191.97020074492;3497.6502349765074;3579.6420357964257;3697.7226707997006;3698.778073315583;4412.40432541606;31234.37531249385;31317.530237046463;31564.842175789203;31620.051398458083;31975.040748777574;3334.366470370646;3369.494575813623;3416.572928383952;3419.5212670226188;3445.87939422119;542462;543560;544455;546404;547825;60756;61183;61216.775664486464;61222;61259.08111378333;35317.47023794645;35780;35971.64028359735;37424.25151496955;37632.43551346732;17563.297468101387;17825.37611183628;17833.286668533372;17845.553861153316;17900.925944443374;12401.441935112942;12574.245545267313;13489.66275843092;13602.727945441036;13636.454541818415;19242.518937026685;19445.05091002911;19859.404217873198;19908.90045549763;20089.397318080482;7918.485298455582;7986.201379861967;8018.639161237758;8023.318017968421;8066.516009039477;906.8141031088611;1000.2648053680539;1043.6034306963306;1055.3087727538475;1125.8311253311904;28136.707851734;30597.23506912345;30757;30983.535246970863;31376.37247255042;952.3428834104445;1003.5985605757755;1139.2936379444798;1201.5133870782347;1278.3735969374939;14541.491047813275;15795.131267780382;15809.841901581067;15904.920475397781;16056.75914861278;727645;730866;733263;733467;734738;50119;58711;59201.40798591959;59250.70374648186;59288.11067833986;1252.7870262055471;1295.2552282437637;1407.7184563087628;1414.158575647488;1457.511733569245;29956.95581096524;31950;32180.517292241104;32316.66192053469;32535.18662033468;48607.75696121497;49017;49079.75460122676;49096.01807963749;49285.057195423564;457399.7130014329;458045;458485;459502;460840;22975.35783384932;26149.477010460065;26755.33111672224;27291.454170916866;27994.44011119807;46268.8432789183;46359.3046104302;46467;46759.29861052019;46824.063518730116;37426.8128659355;37795.43306850454;37954.24091518099;39621.40567891541;39783;32381.838090809397;35551;35557.1110722234;38246;38280.04299892525;35952.8202358997;37317.626823731414;37857.2428551433;37862.67480638164;37979.81010094932;32148;34110.829445852614;34455.52078229814;34476.13809654779;34513.48229776606;25548.744512554636;25589.488210236064;25610.231693048492;25664.8716756415;26109.608355874298 02:40:31 INFO - PROCESS | 1646 | |2;jquery.html;363.93449179147746;380.1465709482211;389.24292251570694;396.50634959475457;417.8934371735207;20048.097835597397;21188.89405552972;21197.548514811868;21903.99999999998;22008;20182.39452816418;20958.37124886252;21191;21827.345179644595;22463.101475940985;5286.709230992304;5604.299462567179;5631.60578759487;5653.9151912721345;5659.8585035374235;4048.797560121997;5542.528885044776;5654.74553645087;5655.179998900157;5660.801871934483;4175.352820312856;4190.937135942963;6877;6927.134108236471;6933.306669333052;6090.48230900374;6183.690815459209;6897;6914.619695916723;6919.204291506491;6092.268927728656;6095.756169753205;6101.267847858241;6102.115193296947;6111.144439778434;13766;13817.309134543233;22576.75827829469;24797.1321003764;25843.870780646164;2248.4041728941843;2335.3577766114454;2358.25714899806;2487.216526794054;2941.0441606477766;10237.23220758446;10808.459577021118;10850.945745271301;11873.52505899763;13050.804237936438;1698;1900.2493765586034;1904.3905950095975;2060.6805945078536;2081.4484161697164;115655;121538.78461215452;128392.69584138006;130915;131685;11630.418479076012;11674.94162529199;11735.471903764352;11743.236689615147;11965.940170299267;15130.39478420873;15149.62125946838;15157.242137893061;15161.924190378977;15170.165640889856;8931.330150238759;9078.45529268246;9083.545822708838;9086.045965173695;9211.493367864832;9056.501892395981;9058.909410905939;9092.954535227282;9257.074292570689;9273.026332235153;4547.522510136454;4567.566081222279;4590.059037897223;4693.301351722773;4774.021325628238;1784.0990299898467;1855.2208072609537;1902.8477721782224;1945.3385848811472;1952.2288695965015;864.2567392042838;947.4694171264114;975.3124047546463;983.016983016983;1057.9947100264449;20318.28885988983;21639.67540486894;21716.565668686853;21897.233596824353;21988;1029.2177944762034;1040.7346126737634;1041.463646222196;1042.5621239079605;1067.1089640150406;10746.73133171677;11456.4844581994;11593.24643898144;11621.76756464866;11648.53405863773;596174;601860.8883467006;610582;617890;626480;96976;136197;141923;142199;144233;959.3284700709531;978.3689520259393;1002.5739060899089;1011.8836333821705;1015.4618052432223;17465.650686986442;19509.21963121516;19882.701759473908;20005.699914501;20317.898410507853;57366.426335736105;61040.69479652751;62181;62877.68561157165;63286.367136328045;82355.17644823475;86068.13931860852;88418;88936.555317223;91498.08501914896;7551.848963020819;8135.145809689898;8288.792780180544;8574.142585741376;8650.524221167645;10822;11487.25332853362;13151.079424440197;13165.275909825052;13509.72980540364;10536.78926421452;11297.548098076313;11375.089992800722;11650.941745291218;11844.111691622991;10431.478426078818;11045.005949464587;11153.55385784592;11252.549898003988;11383.146264030065;10883.292585981886;11233.32600044;11317;11365.829512557153;11546.48040838181;8228.300594449538;8230.395072960715;8414.6213420395;8424.326053915795;8494;9869.358491698016;11316.26444281119;11322.207445478738;11435.714107147387;11733.120015998664 02:40:31 INFO - PROCESS | 1646 | |3;mootools.html;1557.2836495212198;1578.8421157884213;1781.6703909776693;1920.7791104023042;1950.6976418655113;8726.694565690203;9330.953345233273;9346.252299816015;9349.111834375723;9364;8102.635381407836;8384.245417912387;8742.737717868475;8962.103789621035;8998.775030624238;2402.05118978004;2427.78149966503;2435.074671624789;2438.341647755114;2439.8048156147465;2396.3529846941315;2404.663347131403;2442.694663167104;2447.3514518652573;2447.5227330670527;2419.3346829621905;2422.0069771393732;2427.7329493755674;2436.8172387070954;2440.2923152285903;2047.692846073086;2391.844530105555;2400.927972160829;2411.05968672218;2415.4323733922515;2375.8218133639875;2404.9639255411184;2425.442148305882;2427.9514409711883;2430.829841911067;9202.171804537624;9304.488253146073;9310.115539023782;9320.161185493338;9347.626094956193;4681.859544213679;5554.250176226238;5559.249501317311;5565.888682226333;5571.192177134293;3499.33512632599;3653.1780349421433;3674.4672022556847;3693.5752388475403;3720.069982504374;1075.123774124094;1098.8791232964368;1108.706192858893;1124.196199717198;1124.2804605052772;11954.58158964432;12024.398780060961;12059.517619295219;12070;12103.576374826927;4739.3601863748645;4762.966817832572;4816.54242846929;4930.038642464757;4934.851954441372;10339.276250662382;10340.121089707309;10340.586376545005;10362.067413932782;10372.01465860742;5455.918161227585;5482.671039737628;5490.450954904558;5491.2312276281355;5498.092814685532;4514.909701805946;4694.295855621615;4907.950920490749;5026.773795179226;5033.5469807716745;3431.605365382963;4062.674986001172;4187.14163596462;4220.40914271996;4224.260754368035;1140.3329052504212;1307.215670597653;1312.9277889716157;1316.6839958409912;1327.3164320375015;849.8640217565284;880.3221519430003;913.3378300732049;915.2449229385784;934.3833070173789;5393.2449457076045;5998.790042348497;6014.6391216527145;6181.474574661114;6352.824727425349;439.65047787009405;439.9384086227931;445.91081783643403;467.58385037316816;469.064216887312;3932.3708206687365;4049.5806427670504;4111.342185250345;4114.321137012359;4136.607022332873;10768.246222764332;11268.15488838324;11288.830667539829;11300.943495282636;11325.263857849213;11187.608433704781;11211.55153793839;11230.270032448028;11232.719182020515;11237.38194399316;8370.874436883452;8371.079181290053;8464.915350846535;8554.44396114263;8557.272631826365;5205.609579281645;5865.208196893535;5885.676287804212;6117.571769976059;6122.112293717475;10385.221108416748;10449.791004179722;10461.895381046092;10486.003829636173;10503.159747220052;10387.065164135263;10434.478276086316;10475.790484190426;10596.682099537025;10787.244892857738;7209.170945341353;7409.2590740927635;7714.6914123434435;7795.766127016199;8010.439269251096;8759.518226497605;8947.552622368725;8953.820923581361;8955.731328060168;8966.148215919477;7763.184865589032;7908.327792137733;7942.801429964297;7998.080220774686;8022.197780221931;7674.6162691864065;7763.378929685498;7800.492967957065;7801.531908085533;7816.57008864518;7356.264373562601;7357.227491113356;7357.411407087313;7360.447966402434;7363.631818409165;4929.260610908393;4968.105740966661;4975.154223781893;5094.2613321068975;5229.084910140634;5110.693358398508;5157.226416037624;5218.947810521998;5374.946250537445;5379.300690910157 02:40:31 INFO - PROCESS | 1646 | |4;prototype.html;282.2281061297353;309.6207146245848;319.18925928142517;320.6697101984956;330.4300082357934;5396.757145928433;5428.859939412728;5438.836834894954;5439.401665816757;5454.91817622735;5037.924431133527;5380.461953804617;5404.675719456835;5440.537554307879;5516.172574113875;4043.3328500797334;4081.8163182656854;4094.324436467979;4131.52487463941;4166.625003749662;3489.389356862539;3614.060344310472;4183.995840998154;4188.916221675565;4283.507396649394;3617.3669607818656;4028.7582745035393;4130.0294430808735;4176.916461670765;4185.309423945046;4025.7987100644996;4151.335786274181;4158.563350848148;4163.667626359566;4196.559361267069;3020.3506246156962;3045.923851903698;3610.4403817408343;3613.295407395559;3648.1426864686778;4682.882927926829;5374.167004114369;5392.56859451243;5455.51773942855;5462.426445223234;4373.540778218273;4474.769438404433;4806.663533552653;4827.951720482785;4913.877153071202;4992.301077849104;5544.500994910437;5555;5639.379668236491;5692.48767610917;3710.387786015331;3858.4405261237243;3968.8809335719975;3996.440498330236;4011.618896204856;5037.899242015176;5782.913256301159;6024.728887200086;6041.78853740117;6174.876502469971;3492.388831954398;4057.6145266199665;4064.4919385076864;4073.714839961174;4077.55146933837;4148.69316165413;4154.91690166195;4156.2726522858375;4159.958400416018;4190.988325603727;4626.825392065791;4808.591269742041;4819.373481447389;4840.709557426566;4855.878603034952;4880.365552478226;5310.522053015247;5822.796202132905;5867.589268751147;5886.529077673776;1327.6282640860575;1366.2758737868946;1401.9228942408265;1421.6090575091932;1441.7981482592445;801.4309840013656;830.8670612701939;843.8143608406141;891.3003292415423;927.3601215161517;4556.658250631216;5025.296458495814;5404.32445944257;5614.101743720985;5660.462256085665;5478.808241711521;5917.668524581934;5944.702764861826;5992.490638295706;6012.669303188367;4864.902701946012;5062.582476906472;5343.545798607084;5604.635698679573;5616.943830561724;2500.1874390823054;2790.9952417129816;3046.3754930239693;3076.2926575750676;3108.564800927872;4337.570960262263;5661.433856614306;5926.140709597084;6020.638761674313;6161.8266592704795;5121.103806833789;5372.462753724674;6025.246844144482;6065.239551478112;6120.41856023686;4966.950330496648;6064.393560643988;6135.202423684892;6149.354317796567;6213.689315534296;4785.545373189541;5710.3990626645345;5734.587920187481;5850.7074646266665;5939.46544810969;5308.654937429054;5570.554355651457;5835.56233282514;5880.8235752927485;5939.732712027882;5594.356648985256;5955.166276721176;6152;6201.658908760061;6212.534059945612;3220.565223694865;3796.5952597539085;3823.617638236154;3857.864974725871;4056.8174432150035;5241.9737901310245;5650.943490565206;5815.273090863642;5903.173555702119;5913.46778789911;5150.278960945396;5588.636738611977;5811.389804070681;5824.504917081926;5871.559633027455;4549.545045495424;4648;4674.742889140994;4894.2169252920785;5724.685142317213;5404.378496472798;5616.494515493625;5643.4886475518;5679.35298763354;5698.914516282342;4763.499832517536;5683.2895888014;5731.828045158652;5815.651060936358;5903.852403689943;5279.656822306538;5749.04532458966;5754.338251101177;5756.971215143897;5766.94233057664 02:40:31 INFO - PROCESS | 1646 | |5;yui.html;637.2225884421008;740.3965767899161;806.8265322955564;824.5300178898027;845.6067928413287;16176;16818.579535511588;16834.66330673386;16835.15824208789;16847.49457516275;15023.849761502383;15087.62280942977;15121.395144194219;15137.772933406008;15140;724.5652608434949;751.4439314906957;753.815315247765;755.2485277149244;886.8004698942734;736.0909277042848;742.2948199210745;880.6697488441835;915.0940568836837;921.8525035994243;963.6434519227895;975.9801007946712;980.7989362180735;982.076847763104;983.5918093990986;963.4412041016229;964.0793042644258;965.0928127560142;968.0126271203403;968.2012339819642;721.3183541553234;722.6242353975956;723.6562632749454;723.8009547374462;723.9927600723978;15227.238638068164;15474.5357639271;15501.147436891079;15527.45653902108;15540.61148471286;13462.730745385037;13685.863141368558;13692.65768355799;13905.582832515041;14042.578722638234;12899.29053902035;13322.467101315935;13348;13454.394552245172;13493.2578708171;4662.95337046632;4767.7616119194245;4799.784009719571;4870.0746858096845;4958.454569997298;128303;129699.35150324283;132824;134750.32624836912;134902.3254883729;11101.611443599435;11410.885891140982;11411.771764564663;11424;11443.370614616277;22780;23302.76697233006;23323.88338058299;23325;23330;8305.044919834296;8368.288695460833;8386.245237928615;8432.494050356998;8478.321734261244;4567.954320456819;4705.205579992979;4718.386609740781;4747.881302967454;4755.453122890843;3533.94699079514;3673.4673472346362;3674.375356189454;3677.099110717891;3685.0787303174206;669.3808227389645;682.5392859819602;684.5174152222671;703.6516924122592;704.1831475488511;589.3016775121495;591.9378465261171;624.9906251406233;632.2855173653742;713.9286071392819;8442.451240669337;9066.863997040049;9194.03462636427;9284.210842078364;9597.568109435093;544.4473859033085;621.9004959206505;662.5060488598181;663.7577284291199;663.8074958262147;4312.482502099705;4503.662225333048;4590.648088560275;4617.422822147231;4700.130475861976;77048;138354;144116.27941860224;150693.24653376662;151390;123372.38313808553;128154.71845281615;129578.35210824074;134026;136819;77140;104929.47535262427;105276;110271;112603;9976.750581235527;10218.182545396201;10264;10313.9484302578;10384.915007090969;45911.77044114892;62101;62895;63791.76728814469;64390;88970.66544001715;91488;92916;97616;100276.49861750644;13085.280309583064;13192.274424906338;13404.262765547599;13973.650658733613;14265.42938282457;15203.31585078652;15680.607984800472;16227.675446490768;16400.589985250463;16732.58168545796;12271.69320766988;13763.518276860263;14079.296035198404;14813.851861481678;15314.38742450334;14169.149851008973;14437.85562144407;14551.199684017482;14704.55886323412;14734;11677.868339802742;13095.738085238432;13350.065495415227;13777.380017899019;13924.651883702989;11197;11360.261582997078;11470;12026.579069732517;12144.265568451267;8226.753197404087;10149.847752283575;11832.822507662564;11855.585054523395;12041.578544750892 02:40:31 INFO - PROCESS | 1646 | __end_tp_report 02:40:31 INFO - PROCESS | 1646 | __start_cc_report 02:40:31 INFO - PROCESS | 1646 | _x_x_mozilla_cycle_collect,1134 02:40:31 INFO - PROCESS | 1646 | __end_cc_report 02:40:31 INFO - PROCESS | 1646 | __startTimestamp1483612831186__endTimestamp 02:40:31 INFO - PROCESS | 1646 | 02:40:31 INFO - PROCESS | 1646 | ------- Summary: start ------- 02:40:31 INFO - PROCESS | 1646 | Number of tests: 6 02:40:31 INFO - PROCESS | 1646 | 02:40:31 INFO - PROCESS | 1646 | [#0] dojo.html Cycles:165 Average:5822.42 Median:6112.69 stddev:639.14 (10.5%) stddev-sans-first:607.37 02:40:31 INFO - PROCESS | 1646 | Values: 3210.5 3422.1 3428.7 3487.5 3515.7 5690.3 5791.1 5836.3 5836.6 5854.9 5781.8 5859.7 5864.1 5870.1 5883.0 5236.3 5272.7 5286.3 5330.6 5344.0 5220.7 5224.8 5238.0 5244.7 5375.9 5224.1 5315.5 5322.0 5333.7 5344.7 5307.4 5310.9 5316.1 5322.5 5365.9 5148.8 5184.8 5195.4 5275.9 5276.3 5701.1 5701.6 5788.4 5799.2 5804.2 6198.8 6239.0 6259.5 6286.6 6295.2 6240.6 6251.2 6260.5 6265.0 6265.6 5675.7 5785.3 5817.9 5839.6 5841.4 6305.6 6310.7 6332.3 6334.1 6335.6 6230.4 6241.0 6250.1 6252.9 6257.9 6164.7 6179.9 6219.9 6246.0 6253.2 6156.1 6174.2 6181.0 6181.3 6197.4 5200.0 6156.2 6200.4 6211.3 6221.8 4887.6 4907.8 4936.2 4951.6 4966.0 4466.7 4494.1 4500.9 4527.0 4571.7 5993.7 6003.8 6003.9 6006.5 6039.2 6145.5 6183.4 6296.9 6299.9 6313.0 5929.0 5999.1 6017.8 6054.5 6107.4 5459.9 5505.6 5506.0 5507.7 5511.2 6249.2 6451.4 6453.3 6461.1 6471.7 6191.3 6198.8 6267.7 6274.8 6296.3 6403.7 6407.9 6422.6 6433.5 6456.0 6249.1 6253.4 6254.5 6279.5 6299.1 6046.2 6157.9 6181.8 6250.7 6297.2 6239.5 6242.0 6245.2 6253.3 6263.3 6215.2 6215.8 6245.8 6251.3 6259.5 5946.7 6011.6 6045.0 6066.4 6069.0 6215.8 6233.3 6254.1 6258.5 6261.0 6112.7 6114.7 6122.2 6144.0 6151.5 02:40:31 INFO - PROCESS | 1646 | 02:40:31 INFO - PROCESS | 1646 | [#1] ext.html Cycles:180 Average:70734.33 Median:34494.81 stddev:157927.10 (457.8%) stddev-sans-first:158282.01 02:40:31 INFO - PROCESS | 1646 | Values: 470.2 497.3 499.7 518.5 520.9 31052.0 40277.2 40857.6 40895.8 44323.0 43810.3 44095.0 44107.3 44130.8 44205.8 9985.7 10187.9 10196.8 10197.5 10200.2 9237.4 9490.0 12296.6 12526.4 12598.8 12300.9 12326.0 12437.6 12530.2 12552.4 12436.6 12522.1 12528.3 12545.1 12549.6 12248.7 12303.3 12332.9 12348.9 12355.9 40804.8 41087.2 41151.0 41186.0 41192.0 3497.7 3579.6 3697.7 3698.8 4412.4 31234.4 31317.5 31564.8 31620.1 31975.0 3334.4 3369.5 3416.6 3419.5 3445.9 542462.0 543560.0 544455.0 546404.0 547825.0 60756.0 61183.0 61216.8 61222.0 61259.1 35317.5 35780.0 35971.6 37424.3 37632.4 17563.3 17825.4 17833.3 17845.6 17900.9 12401.4 12574.2 13489.7 13602.7 13636.5 19242.5 19445.1 19859.4 19908.9 20089.4 7918.5 7986.2 8018.6 8023.3 8066.5 906.8 1000.3 1043.6 1055.3 1125.8 28136.7 30597.2 30757.0 30983.5 31376.4 952.3 1003.6 1139.3 1201.5 1278.4 14541.5 15795.1 15809.8 15904.9 16056.8 727645.0 730866.0 733263.0 733467.0 734738.0 50119.0 58711.0 59201.4 59250.7 59288.1 1252.8 1295.3 1407.7 1414.2 1457.5 29957.0 31950.0 32180.5 32316.7 32535.2 48607.8 49017.0 49079.8 49096.0 49285.1 457399.7 458045.0 458485.0 459502.0 460840.0 22975.4 26149.5 26755.3 27291.5 27994.4 46268.8 46359.3 46467.0 46759.3 46824.1 37426.8 37795.4 37954.2 39621.4 39783.0 32381.8 35551.0 35557.1 38246.0 38280.0 35952.8 37317.6 37857.2 37862.7 37979.8 32148.0 34110.8 34455.5 34476.1 34513.5 25548.7 25589.5 25610.2 25664.9 26109.6 02:40:31 INFO - PROCESS | 1646 | 02:40:31 INFO - PROCESS | 1646 | [#2] jquery.html Cycles:180 Average:36291.66 Median:21946.00 stddev:102291.39 (466.1%) stddev-sans-first:102542.77 02:40:31 INFO - PROCESS | 1646 | Values: 363.9 380.1 389.2 396.5 417.9 20048.1 21188.9 21197.5 21904.0 22008.0 20182.4 20958.4 21191.0 21827.3 22463.1 5286.7 5604.3 5631.6 5653.9 5659.9 4048.8 5542.5 5654.7 5655.2 5660.8 4175.4 4190.9 6877.0 6927.1 6933.3 6090.5 6183.7 6897.0 6914.6 6919.2 6092.3 6095.8 6101.3 6102.1 6111.1 13766.0 13817.3 22576.8 24797.1 25843.9 2248.4 2335.4 2358.3 2487.2 2941.0 10237.2 10808.5 10850.9 11873.5 13050.8 1698.0 1900.2 1904.4 2060.7 2081.4 115655.0 121538.8 128392.7 130915.0 131685.0 11630.4 11674.9 11735.5 11743.2 11965.9 15130.4 15149.6 15157.2 15161.9 15170.2 8931.3 9078.5 9083.5 9086.0 9211.5 9056.5 9058.9 9093.0 9257.1 9273.0 4547.5 4567.6 4590.1 4693.3 4774.0 1784.1 1855.2 1902.8 1945.3 1952.2 864.3 947.5 975.3 983.0 1058.0 20318.3 21639.7 21716.6 21897.2 21988.0 1029.2 1040.7 1041.5 1042.6 1067.1 10746.7 11456.5 11593.2 11621.8 11648.5 596174.0 601860.9 610582.0 617890.0 626480.0 96976.0 136197.0 141923.0 142199.0 144233.0 959.3 978.4 1002.6 1011.9 1015.5 17465.7 19509.2 19882.7 20005.7 20317.9 57366.4 61040.7 62181.0 62877.7 63286.4 82355.2 86068.1 88418.0 88936.6 91498.1 7551.8 8135.1 8288.8 8574.1 8650.5 10822.0 11487.3 13151.1 13165.3 13509.7 10536.8 11297.5 11375.1 11650.9 11844.1 10431.5 11045.0 11153.6 11252.5 11383.1 10883.3 11233.3 11317.0 11365.8 11546.5 8228.3 8230.4 8414.6 8424.3 8494.0 9869.4 11316.3 11322.2 11435.7 11733.1 02:40:31 INFO - PROCESS | 1646 | 02:40:31 INFO - PROCESS | 1646 | [#3] mootools.html Cycles:180 Average:5915.23 Median:2575.46 stddev:3377.98 (131.2%) stddev-sans-first:3371.58 02:40:31 INFO - PROCESS | 1646 | Values: 1557.3 1578.8 1781.7 1920.8 1950.7 8726.7 9331.0 9346.3 9349.1 9364.0 8102.6 8384.2 8742.7 8962.1 8998.8 2402.1 2427.8 2435.1 2438.3 2439.8 2396.4 2404.7 2442.7 2447.4 2447.5 2419.3 2422.0 2427.7 2436.8 2440.3 2047.7 2391.8 2400.9 2411.1 2415.4 2375.8 2405.0 2425.4 2428.0 2430.8 9202.2 9304.5 9310.1 9320.2 9347.6 4681.9 5554.3 5559.2 5565.9 5571.2 3499.3 3653.2 3674.5 3693.6 3720.1 1075.1 1098.9 1108.7 1124.2 1124.3 11954.6 12024.4 12059.5 12070.0 12103.6 4739.4 4763.0 4816.5 4930.0 4934.9 10339.3 10340.1 10340.6 10362.1 10372.0 5455.9 5482.7 5490.5 5491.2 5498.1 4514.9 4694.3 4908.0 5026.8 5033.5 3431.6 4062.7 4187.1 4220.4 4224.3 1140.3 1307.2 1312.9 1316.7 1327.3 849.9 880.3 913.3 915.2 934.4 5393.2 5998.8 6014.6 6181.5 6352.8 439.7 439.9 445.9 467.6 469.1 3932.4 4049.6 4111.3 4114.3 4136.6 10768.2 11268.2 11288.8 11300.9 11325.3 11187.6 11211.6 11230.3 11232.7 11237.4 8370.9 8371.1 8464.9 8554.4 8557.3 5205.6 5865.2 5885.7 6117.6 6122.1 10385.2 10449.8 10461.9 10486.0 10503.2 10387.1 10434.5 10475.8 10596.7 10787.2 7209.2 7409.3 7714.7 7795.8 8010.4 8759.5 8947.6 8953.8 8955.7 8966.1 7763.2 7908.3 7942.8 7998.1 8022.2 7674.6 7763.4 7800.5 7801.5 7816.6 7356.3 7357.2 7357.4 7360.4 7363.6 4929.3 4968.1 4975.2 5094.3 5229.1 5110.7 5157.2 5218.9 5374.9 5379.3 02:40:31 INFO - PROCESS | 1646 | 02:40:31 INFO - PROCESS | 1646 | [#4] prototype.html Cycles:180 Average:4648.88 Median:5294.16 stddev:1439.37 (27.2%) stddev-sans-first:1405.59 02:40:31 INFO - PROCESS | 1646 | Values: 282.2 309.6 319.2 320.7 330.4 5396.8 5428.9 5438.8 5439.4 5454.9 5037.9 5380.5 5404.7 5440.5 5516.2 4043.3 4081.8 4094.3 4131.5 4166.6 3489.4 3614.1 4184.0 4188.9 4283.5 3617.4 4028.8 4130.0 4176.9 4185.3 4025.8 4151.3 4158.6 4163.7 4196.6 3020.4 3045.9 3610.4 3613.3 3648.1 4682.9 5374.2 5392.6 5455.5 5462.4 4373.5 4474.8 4806.7 4828.0 4913.9 4992.3 5544.5 5555.0 5639.4 5692.5 3710.4 3858.4 3968.9 3996.4 4011.6 5037.9 5782.9 6024.7 6041.8 6174.9 3492.4 4057.6 4064.5 4073.7 4077.6 4148.7 4154.9 4156.3 4160.0 4191.0 4626.8 4808.6 4819.4 4840.7 4855.9 4880.4 5310.5 5822.8 5867.6 5886.5 1327.6 1366.3 1401.9 1421.6 1441.8 801.4 830.9 843.8 891.3 927.4 4556.7 5025.3 5404.3 5614.1 5660.5 5478.8 5917.7 5944.7 5992.5 6012.7 4864.9 5062.6 5343.5 5604.6 5616.9 2500.2 2791.0 3046.4 3076.3 3108.6 4337.6 5661.4 5926.1 6020.6 6161.8 5121.1 5372.5 6025.2 6065.2 6120.4 4967.0 6064.4 6135.2 6149.4 6213.7 4785.5 5710.4 5734.6 5850.7 5939.5 5308.7 5570.6 5835.6 5880.8 5939.7 5594.4 5955.2 6152.0 6201.7 6212.5 3220.6 3796.6 3823.6 3857.9 4056.8 5242.0 5650.9 5815.3 5903.2 5913.5 5150.3 5588.6 5811.4 5824.5 5871.6 4549.5 4648.0 4674.7 4894.2 5724.7 5404.4 5616.5 5643.5 5679.4 5698.9 4763.5 5683.3 5731.8 5815.7 5903.9 5279.7 5749.0 5754.3 5757.0 5766.9 02:40:31 INFO - PROCESS | 1646 | 02:40:31 INFO - PROCESS | 1646 | [#5] yui.html Cycles:180 Average:25169.10 Median:23327.50 stddev:39719.03 (170.3%) stddev-sans-first:39787.74 02:40:31 INFO - PROCESS | 1646 | Values: 637.2 740.4 806.8 824.5 845.6 16176.0 16818.6 16834.7 16835.2 16847.5 15023.8 15087.6 15121.4 15137.8 15140.0 724.6 751.4 753.8 755.2 886.8 736.1 742.3 880.7 915.1 921.9 963.6 976.0 980.8 982.1 983.6 963.4 964.1 965.1 968.0 968.2 721.3 722.6 723.7 723.8 724.0 15227.2 15474.5 15501.1 15527.5 15540.6 13462.7 13685.9 13692.7 13905.6 14042.6 12899.3 13322.5 13348.0 13454.4 13493.3 4663.0 4767.8 4799.8 4870.1 4958.5 128303.0 129699.4 132824.0 134750.3 134902.3 11101.6 11410.9 11411.8 11424.0 11443.4 22780.0 23302.8 23323.9 23325.0 23330.0 8305.0 8368.3 8386.2 8432.5 8478.3 4568.0 4705.2 4718.4 4747.9 4755.5 3533.9 3673.5 3674.4 3677.1 3685.1 669.4 682.5 684.5 703.7 704.2 589.3 591.9 625.0 632.3 713.9 8442.5 9066.9 9194.0 9284.2 9597.6 544.4 621.9 662.5 663.8 663.8 4312.5 4503.7 4590.6 4617.4 4700.1 77048.0 138354.0 144116.3 150693.2 151390.0 123372.4 128154.7 129578.4 134026.0 136819.0 77140.0 104929.5 105276.0 110271.0 112603.0 9976.8 10218.2 10264.0 10313.9 10384.9 45911.8 62101.0 62895.0 63791.8 64390.0 88970.7 91488.0 92916.0 97616.0 100276.5 13085.3 13192.3 13404.3 13973.7 14265.4 15203.3 15680.6 16227.7 16400.6 16732.6 12271.7 13763.5 14079.3 14813.9 15314.4 14169.1 14437.9 14551.2 14704.6 14734.0 11677.9 13095.7 13350.1 13777.4 13924.7 11197.0 11360.3 11470.0 12026.6 12144.3 8226.8 10149.8 11832.8 11855.6 12041.6 02:40:31 INFO - PROCESS | 1646 | -------- Summary: end -------- 02:40:31 INFO - PROCESS | 1646 | 02:40:31 INFO - TEST-INFO | 1646: exit 0 02:40:31 INFO - TEST-OK | dromaeo_css | took 1114656ms 02:40:31 INFO - TEST-START | kraken 02:40:31 INFO - operating with platform_type : mac_ 02:40:31 INFO - Initialising browser for kraken test... 02:40:31 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/tmpwuFwYc/profile http://localhost:49247/getInfo.html) 02:40:33 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 02:40:33 INFO - PROCESS | 1653 | colorDepth:24 02:40:33 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 02:40:33 INFO - PROCESS | 1653 | __metrics 02:40:33 INFO - PROCESS | 1653 | 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" 02:40:33 INFO - PROCESS | 1653 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:40:34 INFO - TEST-INFO | 1653: exit 0 02:40:34 INFO - Browser initialized. 02:40:34 INFO - Running cycle 1/1 for kraken test... 02:40:34 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/tmpwuFwYc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:40:46 INFO - PROCESS | 1655 | RSS: Main: 169013248 02:40:46 INFO - PROCESS | 1655 | 02:40:49 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-beat-detection) 02:40:50 INFO - PROCESS | 1655 | RSS: Main: 218537984 02:40:50 INFO - PROCESS | 1655 | 02:40:52 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-dft) 02:40:53 INFO - PROCESS | 1655 | RSS: Main: 231976960 02:40:53 INFO - PROCESS | 1655 | 02:40:56 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-fft) 02:40:57 INFO - PROCESS | 1655 | RSS: Main: 329961472 02:40:57 INFO - PROCESS | 1655 | 02:40:59 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-oscillator) 02:40:59 INFO - PROCESS | 1655 | RSS: Main: 228184064 02:40:59 INFO - PROCESS | 1655 | 02:41:01 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49247/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:41:02 INFO - PROCESS | 1655 | RSS: Main: 229998592 02:41:02 INFO - PROCESS | 1655 | 02:41:04 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49247/tests/kraken/driver.html?testName=imaging-darkroom) 02:41:05 INFO - PROCESS | 1655 | RSS: Main: 267640832 02:41:05 INFO - PROCESS | 1655 | 02:41:08 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49247/tests/kraken/driver.html?testName=imaging-desaturate) 02:41:08 INFO - PROCESS | 1655 | RSS: Main: 268906496 02:41:08 INFO - PROCESS | 1655 | 02:41:11 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49247/tests/kraken/driver.html?testName=json-parse-financial) 02:41:12 INFO - PROCESS | 1655 | RSS: Main: 266625024 02:41:12 INFO - PROCESS | 1655 | 02:41:13 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49247/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:41:14 INFO - PROCESS | 1655 | RSS: Main: 240009216 02:41:14 INFO - PROCESS | 1655 | 02:41:16 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:41:16 INFO - PROCESS | 1655 | RSS: Main: 245608448 02:41:16 INFO - PROCESS | 1655 | 02:41:19 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:41:19 INFO - PROCESS | 1655 | RSS: Main: 253247488 02:41:19 INFO - PROCESS | 1655 | 02:41:22 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:41:23 INFO - PROCESS | 1655 | RSS: Main: 260206592 02:41:23 INFO - PROCESS | 1655 | 02:41:25 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:41:26 INFO - PROCESS | 1655 | RSS: Main: 260284416 02:41:26 INFO - PROCESS | 1655 | 02:41:28 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49247/tests/kraken/driver.html?testName=ai-astar) 02:41:28 INFO - PROCESS | 1655 | RSS: Main: 303800320 02:41:28 INFO - PROCESS | 1655 | 02:41:28 INFO - PROCESS | 1655 | __start_tp_report 02:41:28 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 02:41:28 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 02:41:28 INFO - PROCESS | 1655 | |i|pagename|runs| 02:41:28 INFO - PROCESS | 1655 | |0;ai-astar;115;113;113;112;112;114;112;111;113;113 02:41:28 INFO - PROCESS | 1655 | |1;audio-beat-detection;141;108;108;139;107;109;107;106;136;108 02:41:28 INFO - PROCESS | 1655 | |2;audio-dft;183;183;184;181;183;184;185;181;183;181 02:41:28 INFO - PROCESS | 1655 | |3;audio-fft;80;58;58;87;59;58;59;76;103;74 02:41:28 INFO - PROCESS | 1655 | |4;audio-oscillator;84;70;92;70;69;68;92;67;69;89 02:41:28 INFO - PROCESS | 1655 | |5;imaging-gaussian-blur;87;84;87;84;88;83;87;85;87;84 02:41:28 INFO - PROCESS | 1655 | |6;imaging-darkroom;93;93;94;92;94;93;92;93;94;93 02:41:28 INFO - PROCESS | 1655 | |7;imaging-desaturate;86;84;80;87;87;98;135;136;84;86 02:41:28 INFO - PROCESS | 1655 | |8;json-parse-financial;56;53;54;52;55;58;57;55;56;56 02:41:28 INFO - PROCESS | 1655 | |9;json-stringify-tinderbox;73;65;67;75;71;67;67;68;67;69 02:41:28 INFO - PROCESS | 1655 | |10;stanford-crypto-aes;84;77;81;79;81;81;82;81;87;89 02:41:28 INFO - PROCESS | 1655 | |11;stanford-crypto-ccm;140;138;142;136;133;134;137;136;166;146 02:41:28 INFO - PROCESS | 1655 | |12;stanford-crypto-pbkdf2;159;158;160;161;162;160;160;160;160;160 02:41:28 INFO - PROCESS | 1655 | |13;stanford-crypto-sha256-iterative;65;65;65;63;77;81;80;78;64;66 02:41:28 INFO - PROCESS | 1655 | __end_tp_report 02:41:28 INFO - PROCESS | 1655 | __start_cc_report 02:41:28 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,1857 02:41:28 INFO - PROCESS | 1655 | __end_cc_report 02:41:28 INFO - PROCESS | 1655 | __startTimestamp1483612888491__endTimestamp 02:41:28 INFO - PROCESS | 1655 | 02:41:28 INFO - PROCESS | 1655 | ------- Summary: start ------- 02:41:28 INFO - PROCESS | 1655 | Number of tests: 14 02:41:28 INFO - PROCESS | 1655 | 02:41:28 INFO - PROCESS | 1655 | [#0] ai-astar Cycles:10 Average:112.80 Median:113.00 stddev:1.14 (1.0%) stddev-sans-first:0.88 02:41:28 INFO - PROCESS | 1655 | Values: 115.0 113.0 113.0 112.0 112.0 114.0 112.0 111.0 113.0 113.0 02:41:28 INFO - PROCESS | 1655 | 02:41:28 INFO - PROCESS | 1655 | [#1] audio-beat-detection Cycles:10 Average:116.90 Median:108.50 stddev:15.09 (13.9%) stddev-sans-first:13.25 02:41:28 INFO - PROCESS | 1655 | Values: 141.0 108.0 108.0 139.0 107.0 109.0 107.0 106.0 136.0 108.0 02:41:28 INFO - PROCESS | 1655 | 02:41:28 INFO - PROCESS | 1655 | [#2] audio-dft Cycles:10 Average:182.80 Median:183.00 stddev:1.40 (0.8%) stddev-sans-first:1.48 02:41:28 INFO - PROCESS | 1655 | Values: 183.0 183.0 184.0 181.0 183.0 184.0 185.0 181.0 183.0 181.0 02:41:28 INFO - PROCESS | 1655 | 02:41:28 INFO - PROCESS | 1655 | [#3] audio-fft Cycles:10 Average:71.20 Median:66.50 stddev:15.60 (23.5%) stddev-sans-first:16.22 02:41:28 INFO - PROCESS | 1655 | Values: 80.0 58.0 58.0 87.0 59.0 58.0 59.0 76.0 103.0 74.0 02:41:28 INFO - PROCESS | 1655 | 02:41:28 INFO - PROCESS | 1655 | [#4] audio-oscillator Cycles:10 Average:77.00 Median:77.00 stddev:10.80 (14.0%) stddev-sans-first:11.16 02:41:28 INFO - PROCESS | 1655 | Values: 84.0 70.0 92.0 70.0 69.0 68.0 92.0 67.0 69.0 89.0 02:41:28 INFO - PROCESS | 1655 | 02:41:28 INFO - PROCESS | 1655 | [#5] imaging-gaussian-blur Cycles:10 Average:85.60 Median:87.00 stddev:1.78 (2.0%) stddev-sans-first:1.81 02:41:28 INFO - PROCESS | 1655 | Values: 87.0 84.0 87.0 84.0 88.0 83.0 87.0 85.0 87.0 84.0 02:41:28 INFO - PROCESS | 1655 | 02:41:28 INFO - PROCESS | 1655 | [#6] imaging-darkroom Cycles:10 Average:93.10 Median:93.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 02:41:28 INFO - PROCESS | 1655 | Values: 93.0 93.0 94.0 92.0 94.0 93.0 92.0 93.0 94.0 93.0 02:41:28 INFO - PROCESS | 1655 | 02:41:28 INFO - PROCESS | 1655 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:86.00 stddev:21.16 (24.6%) stddev-sans-first:22.11 02:41:28 INFO - PROCESS | 1655 | Values: 86.0 84.0 80.0 87.0 87.0 98.0 135.0 136.0 84.0 86.0 02:41:28 INFO - PROCESS | 1655 | 02:41:28 INFO - PROCESS | 1655 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:56.00 stddev:1.81 (3.2%) stddev-sans-first:1.90 02:41:28 INFO - PROCESS | 1655 | Values: 56.0 53.0 54.0 52.0 55.0 58.0 57.0 55.0 56.0 56.0 02:41:28 INFO - PROCESS | 1655 | 02:41:28 INFO - PROCESS | 1655 | [#9] json-stringify-tinderbox Cycles:10 Average:68.90 Median:68.50 stddev:3.14 (4.6%) stddev-sans-first:2.96 02:41:28 INFO - PROCESS | 1655 | Values: 73.0 65.0 67.0 75.0 71.0 67.0 67.0 68.0 67.0 69.0 02:41:28 INFO - PROCESS | 1655 | 02:41:28 INFO - PROCESS | 1655 | [#10] stanford-crypto-aes Cycles:10 Average:82.20 Median:81.50 stddev:3.58 (4.4%) stddev-sans-first:3.74 02:41:28 INFO - PROCESS | 1655 | Values: 84.0 77.0 81.0 79.0 81.0 81.0 82.0 81.0 87.0 89.0 02:41:28 INFO - PROCESS | 1655 | 02:41:28 INFO - PROCESS | 1655 | [#11] stanford-crypto-ccm Cycles:10 Average:140.80 Median:139.00 stddev:9.66 (6.9%) stddev-sans-first:10.24 02:41:28 INFO - PROCESS | 1655 | Values: 140.0 138.0 142.0 136.0 133.0 134.0 137.0 136.0 166.0 146.0 02:41:28 INFO - PROCESS | 1655 | 02:41:28 INFO - PROCESS | 1655 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.00 Median:160.00 stddev:1.05 (0.7%) stddev-sans-first:1.05 02:41:28 INFO - PROCESS | 1655 | Values: 159.0 158.0 160.0 161.0 162.0 160.0 160.0 160.0 160.0 160.0 02:41:28 INFO - PROCESS | 1655 | 02:41:28 INFO - PROCESS | 1655 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:71.50 stddev:7.52 (10.5%) stddev-sans-first:7.71 02:41:28 INFO - PROCESS | 1655 | Values: 65.0 65.0 65.0 63.0 77.0 81.0 80.0 78.0 64.0 66.0 02:41:28 INFO - PROCESS | 1655 | -------- Summary: end -------- 02:41:28 INFO - PROCESS | 1655 | 02:41:29 INFO - TEST-INFO | 1655: exit 0 02:41:29 INFO - TEST-OK | kraken | took 57547ms 02:41:29 INFO - SUITE-END | took 1172s 02:41:29 INFO - Completed test suite (00:19:32) 02:41:29 INFO - javascript benchmark 02:41:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3210.486322188449, 3422.0931453164912, 3428.6914177724007, 3487.476878468228, 3515.7011654009407, 5690.3171619405675, 5791.07342825148, 5836.2996440427105, 5836.5914385993, 5854.912176317359, 5781.797637082703, 5859.736311865966, 5864.149698293755, 5870.090136028923, 5882.970585147079, 5236.266922630825, 5272.736363181844, 5286.259923610678, 5330.573554115662, 5344.011357898782, 5220.738963051851, 5224.791008359661, 5238.030964271622, 5244.711540865251, 5375.892482150354, 5224.059669259551, 5315.521603055724, 5321.973390133063, 5333.679979201261, 5344.732763361836, 5307.38965019022, 5310.867228319285, 5316.0962636351915, 5322.467753224685, 5365.919511207335, 5148.794048238066, 5184.818531351422, 5195.376554813409, 5275.920861187085, 5276.3140791697215, 5701.087825947829, 5701.572382071361, 5788.363280039192, 5799.21710569072, 5804.245448091721, 6198.783042593487, 6239.032949892774, 6259.453865138143, 6286.559940804145, 6295.181626388586, 6240.563160578761, 6251.156093927307, 6260.530460215502, 6264.9686751566405, 6265.592736472115, 5675.659460432387, 5785.334686511021, 5817.854553636193, 5839.591228614041, 5841.4450627190345, 6305.558610897285, 6310.7475700971445, 6332.271788744261, 6334.081558174039, 6335.588186767845, 6230.376962303733, 6240.968795155995, 6250.062490626442, 6252.906206406908, 6257.937420625826, 6164.660943648142, 6179.876402471926, 6219.906701399483, 6246.000639897595, 6253.187085678833, 6156.07658851167, 6174.197354343996, 6181.041938499539, 6181.289151747516, 6197.411245931719, 5200.0, 6156.199694039746, 6200.3799620038535, 6211.3478084800445, 6221.751129954841, 4887.633427492952, 4907.754612269372, 4936.2102063669645, 4951.603871690256, 4966.0, 4466.6873318867365, 4494.07871386365, 4500.909981800346, 4527.0493196429115, 4571.657125715585, 5993.730282137227, 6003.849903752441, 6003.939960600338, 6006.489448396936, 6039.184710064085, 6145.525073982301, 6183.350748171467, 6296.905546416808, 6299.905501417391, 6313.021481670348, 5928.970355148197, 5999.070144127667, 6017.789377371771, 6054.485368743706, 6107.419795119546, 5459.945400545944, 5505.642133261325, 5505.972470137704, 5507.669539827623, 5511.173324001432, 6249.187605611241, 6451.387118223761, 6453.290138084807, 6461.06314584392, 6471.741130354733, 6191.25704915413, 6198.845028874314, 6267.717952692231, 6274.811755647338, 6296.275928268308, 6403.6798160090875, 6407.871842563216, 6422.550421470452, 6433.517486188648, 6455.9677201613695, 6249.093881387264, 6253.405926436982, 6254.499640028877, 6279.529035322278, 6299.118123462627, 6046.244219472566, 6157.907631385622, 6181.752729890754, 6250.718717657807, 6297.1813664223355, 6239.532035097295, 6242.0, 6245.219347581552, 6253.312135664983, 6263.342349053284, 6215.223097112861, 6215.81352559424, 6245.750169993149, 6251.343608920998, 6259.499240060875, 5946.702664866826, 6011.609245399035, 6044.972354699799, 6066.388391969717, 6069.02895536712, 6215.751369945152, 6233.314335423009, 6254.061890716429, 6258.499320054294, 6261.0, 6112.694365281807, 6114.7248373822395, 6122.204113465221, 6144.0, 6151.477124444473], "value": 5781.27480617486, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [470.18657722140694, 497.286394024575, 499.7451299837082, 518.4763388977133, 520.8593679706479, 31052.0, 40277.19445611086, 40857.59142408579, 40895.795521022425, 44323.0, 43810.342844857274, 44095.0, 44107.338389924174, 44130.77934610323, 44205.77897110518, 9985.650502232442, 10187.949060254725, 10196.827364853025, 10197.490125493732, 10200.183985281197, 9237.399569027992, 9490.0, 12296.631101066982, 12526.43631036601, 12598.81101783474, 12300.938495307511, 12326.013918886467, 12437.564685236019, 12530.18553794005, 12552.37238138094, 12436.626901192933, 12522.123451358408, 12528.310942898137, 12545.1218414711, 12549.623511294676, 12248.693782655415, 12303.261804291682, 12332.938335308356, 12348.938255308665, 12355.876441235563, 40804.79597601993, 41087.178256435, 41151.0, 41185.970350741474, 41191.97020074492, 3497.6502349765074, 3579.6420357964257, 3697.7226707997006, 3698.778073315583, 4412.40432541606, 31234.37531249385, 31317.530237046463, 31564.842175789203, 31620.051398458083, 31975.040748777574, 3334.366470370646, 3369.494575813623, 3416.572928383952, 3419.5212670226188, 3445.87939422119, 542462.0, 543560.0, 544455.0, 546404.0, 547825.0, 60756.0, 61183.0, 61216.775664486464, 61222.0, 61259.08111378333, 35317.47023794645, 35780.0, 35971.64028359735, 37424.25151496955, 37632.43551346732, 17563.297468101387, 17825.37611183628, 17833.286668533372, 17845.553861153316, 17900.925944443374, 12401.441935112942, 12574.245545267313, 13489.66275843092, 13602.727945441036, 13636.454541818415, 19242.518937026685, 19445.05091002911, 19859.404217873198, 19908.90045549763, 20089.397318080482, 7918.485298455582, 7986.201379861967, 8018.639161237758, 8023.318017968421, 8066.516009039477, 906.8141031088611, 1000.2648053680539, 1043.6034306963306, 1055.3087727538475, 1125.8311253311904, 28136.707851734, 30597.23506912345, 30757.0, 30983.535246970863, 31376.37247255042, 952.3428834104445, 1003.5985605757755, 1139.2936379444798, 1201.5133870782347, 1278.3735969374939, 14541.491047813275, 15795.131267780382, 15809.841901581067, 15904.920475397781, 16056.75914861278, 727645.0, 730866.0, 733263.0, 733467.0, 734738.0, 50119.0, 58711.0, 59201.40798591959, 59250.70374648186, 59288.11067833986, 1252.7870262055471, 1295.2552282437637, 1407.7184563087628, 1414.158575647488, 1457.511733569245, 29956.95581096524, 31950.0, 32180.517292241104, 32316.66192053469, 32535.18662033468, 48607.75696121497, 49017.0, 49079.75460122676, 49096.01807963749, 49285.057195423564, 457399.7130014329, 458045.0, 458485.0, 459502.0, 460840.0, 22975.35783384932, 26149.477010460065, 26755.33111672224, 27291.454170916866, 27994.44011119807, 46268.8432789183, 46359.3046104302, 46467.0, 46759.29861052019, 46824.063518730116, 37426.8128659355, 37795.43306850454, 37954.24091518099, 39621.40567891541, 39783.0, 32381.838090809397, 35551.0, 35557.1110722234, 38246.0, 38280.04299892525, 35952.8202358997, 37317.626823731414, 37857.2428551433, 37862.67480638164, 37979.81010094932, 32148.0, 34110.829445852614, 34455.52078229814, 34476.13809654779, 34513.48229776606, 25548.744512554636, 25589.488210236064, 25610.231693048492, 25664.8716756415, 26109.608355874298], "value": 20526.085352481172, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.93449179147746, 380.1465709482211, 389.24292251570694, 396.50634959475457, 417.8934371735207, 20048.097835597397, 21188.89405552972, 21197.548514811868, 21903.99999999998, 22008.0, 20182.39452816418, 20958.37124886252, 21191.0, 21827.345179644595, 22463.101475940985, 5286.709230992304, 5604.299462567179, 5631.60578759487, 5653.9151912721345, 5659.8585035374235, 4048.797560121997, 5542.528885044776, 5654.74553645087, 5655.179998900157, 5660.801871934483, 4175.352820312856, 4190.937135942963, 6877.0, 6927.134108236471, 6933.306669333052, 6090.48230900374, 6183.690815459209, 6897.0, 6914.619695916723, 6919.204291506491, 6092.268927728656, 6095.756169753205, 6101.267847858241, 6102.115193296947, 6111.144439778434, 13766.0, 13817.309134543233, 22576.75827829469, 24797.1321003764, 25843.870780646164, 2248.4041728941843, 2335.3577766114454, 2358.25714899806, 2487.216526794054, 2941.0441606477766, 10237.23220758446, 10808.459577021118, 10850.945745271301, 11873.52505899763, 13050.804237936438, 1698.0, 1900.2493765586034, 1904.3905950095975, 2060.6805945078536, 2081.4484161697164, 115655.0, 121538.78461215452, 128392.69584138006, 130915.0, 131685.0, 11630.418479076012, 11674.94162529199, 11735.471903764352, 11743.236689615147, 11965.940170299267, 15130.39478420873, 15149.62125946838, 15157.242137893061, 15161.924190378977, 15170.165640889856, 8931.330150238759, 9078.45529268246, 9083.545822708838, 9086.045965173695, 9211.493367864832, 9056.501892395981, 9058.909410905939, 9092.954535227282, 9257.074292570689, 9273.026332235153, 4547.522510136454, 4567.566081222279, 4590.059037897223, 4693.301351722773, 4774.021325628238, 1784.0990299898467, 1855.2208072609537, 1902.8477721782224, 1945.3385848811472, 1952.2288695965015, 864.2567392042838, 947.4694171264114, 975.3124047546463, 983.016983016983, 1057.9947100264449, 20318.28885988983, 21639.67540486894, 21716.565668686853, 21897.233596824353, 21988.0, 1029.2177944762034, 1040.7346126737634, 1041.463646222196, 1042.5621239079605, 1067.1089640150406, 10746.73133171677, 11456.4844581994, 11593.24643898144, 11621.76756464866, 11648.53405863773, 596174.0, 601860.8883467006, 610582.0, 617890.0, 626480.0, 96976.0, 136197.0, 141923.0, 142199.0, 144233.0, 959.3284700709531, 978.3689520259393, 1002.5739060899089, 1011.8836333821705, 1015.4618052432223, 17465.650686986442, 19509.21963121516, 19882.701759473908, 20005.699914501, 20317.898410507853, 57366.426335736105, 61040.69479652751, 62181.0, 62877.68561157165, 63286.367136328045, 82355.17644823475, 86068.13931860852, 88418.0, 88936.555317223, 91498.08501914896, 7551.848963020819, 8135.145809689898, 8288.792780180544, 8574.142585741376, 8650.524221167645, 10822.0, 11487.25332853362, 13151.079424440197, 13165.275909825052, 13509.72980540364, 10536.78926421452, 11297.548098076313, 11375.089992800722, 11650.941745291218, 11844.111691622991, 10431.478426078818, 11045.005949464587, 11153.55385784592, 11252.549898003988, 11383.146264030065, 10883.292585981886, 11233.32600044, 11317.0, 11365.829512557153, 11546.48040838181, 8228.300594449538, 8230.395072960715, 8414.6213420395, 8424.326053915795, 8494.0, 9869.358491698016, 11316.26444281119, 11322.207445478738, 11435.714107147387, 11733.120015998664], "value": 9864.036994835355, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1557.2836495212198, 1578.8421157884213, 1781.6703909776693, 1920.7791104023042, 1950.6976418655113, 8726.694565690203, 9330.953345233273, 9346.252299816015, 9349.111834375723, 9364.0, 8102.635381407836, 8384.245417912387, 8742.737717868475, 8962.103789621035, 8998.775030624238, 2402.05118978004, 2427.78149966503, 2435.074671624789, 2438.341647755114, 2439.8048156147465, 2396.3529846941315, 2404.663347131403, 2442.694663167104, 2447.3514518652573, 2447.5227330670527, 2419.3346829621905, 2422.0069771393732, 2427.7329493755674, 2436.8172387070954, 2440.2923152285903, 2047.692846073086, 2391.844530105555, 2400.927972160829, 2411.05968672218, 2415.4323733922515, 2375.8218133639875, 2404.9639255411184, 2425.442148305882, 2427.9514409711883, 2430.829841911067, 9202.171804537624, 9304.488253146073, 9310.115539023782, 9320.161185493338, 9347.626094956193, 4681.859544213679, 5554.250176226238, 5559.249501317311, 5565.888682226333, 5571.192177134293, 3499.33512632599, 3653.1780349421433, 3674.4672022556847, 3693.5752388475403, 3720.069982504374, 1075.123774124094, 1098.8791232964368, 1108.706192858893, 1124.196199717198, 1124.2804605052772, 11954.58158964432, 12024.398780060961, 12059.517619295219, 12070.0, 12103.576374826927, 4739.3601863748645, 4762.966817832572, 4816.54242846929, 4930.038642464757, 4934.851954441372, 10339.276250662382, 10340.121089707309, 10340.586376545005, 10362.067413932782, 10372.01465860742, 5455.918161227585, 5482.671039737628, 5490.450954904558, 5491.2312276281355, 5498.092814685532, 4514.909701805946, 4694.295855621615, 4907.950920490749, 5026.773795179226, 5033.5469807716745, 3431.605365382963, 4062.674986001172, 4187.14163596462, 4220.40914271996, 4224.260754368035, 1140.3329052504212, 1307.215670597653, 1312.9277889716157, 1316.6839958409912, 1327.3164320375015, 849.8640217565284, 880.3221519430003, 913.3378300732049, 915.2449229385784, 934.3833070173789, 5393.2449457076045, 5998.790042348497, 6014.6391216527145, 6181.474574661114, 6352.824727425349, 439.65047787009405, 439.9384086227931, 445.91081783643403, 467.58385037316816, 469.064216887312, 3932.3708206687365, 4049.5806427670504, 4111.342185250345, 4114.321137012359, 4136.607022332873, 10768.246222764332, 11268.15488838324, 11288.830667539829, 11300.943495282636, 11325.263857849213, 11187.608433704781, 11211.55153793839, 11230.270032448028, 11232.719182020515, 11237.38194399316, 8370.874436883452, 8371.079181290053, 8464.915350846535, 8554.44396114263, 8557.272631826365, 5205.609579281645, 5865.208196893535, 5885.676287804212, 6117.571769976059, 6122.112293717475, 10385.221108416748, 10449.791004179722, 10461.895381046092, 10486.003829636173, 10503.159747220052, 10387.065164135263, 10434.478276086316, 10475.790484190426, 10596.682099537025, 10787.244892857738, 7209.170945341353, 7409.2590740927635, 7714.6914123434435, 7795.766127016199, 8010.439269251096, 8759.518226497605, 8947.552622368725, 8953.820923581361, 8955.731328060168, 8966.148215919477, 7763.184865589032, 7908.327792137733, 7942.801429964297, 7998.080220774686, 8022.197780221931, 7674.6162691864065, 7763.378929685498, 7800.492967957065, 7801.531908085533, 7816.57008864518, 7356.264373562601, 7357.227491113356, 7357.411407087313, 7360.447966402434, 7363.631818409165, 4929.260610908393, 4968.105740966661, 4975.154223781893, 5094.2613321068975, 5229.084910140634, 5110.693358398508, 5157.226416037624, 5218.947810521998, 5374.946250537445, 5379.300690910157], "value": 4647.018312398159, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [282.2281061297353, 309.6207146245848, 319.18925928142517, 320.6697101984956, 330.4300082357934, 5396.757145928433, 5428.859939412728, 5438.836834894954, 5439.401665816757, 5454.91817622735, 5037.924431133527, 5380.461953804617, 5404.675719456835, 5440.537554307879, 5516.172574113875, 4043.3328500797334, 4081.8163182656854, 4094.324436467979, 4131.52487463941, 4166.625003749662, 3489.389356862539, 3614.060344310472, 4183.995840998154, 4188.916221675565, 4283.507396649394, 3617.3669607818656, 4028.7582745035393, 4130.0294430808735, 4176.916461670765, 4185.309423945046, 4025.7987100644996, 4151.335786274181, 4158.563350848148, 4163.667626359566, 4196.559361267069, 3020.3506246156962, 3045.923851903698, 3610.4403817408343, 3613.295407395559, 3648.1426864686778, 4682.882927926829, 5374.167004114369, 5392.56859451243, 5455.51773942855, 5462.426445223234, 4373.540778218273, 4474.769438404433, 4806.663533552653, 4827.951720482785, 4913.877153071202, 4992.301077849104, 5544.500994910437, 5555.0, 5639.379668236491, 5692.48767610917, 3710.387786015331, 3858.4405261237243, 3968.8809335719975, 3996.440498330236, 4011.618896204856, 5037.899242015176, 5782.913256301159, 6024.728887200086, 6041.78853740117, 6174.876502469971, 3492.388831954398, 4057.6145266199665, 4064.4919385076864, 4073.714839961174, 4077.55146933837, 4148.69316165413, 4154.91690166195, 4156.2726522858375, 4159.958400416018, 4190.988325603727, 4626.825392065791, 4808.591269742041, 4819.373481447389, 4840.709557426566, 4855.878603034952, 4880.365552478226, 5310.522053015247, 5822.796202132905, 5867.589268751147, 5886.529077673776, 1327.6282640860575, 1366.2758737868946, 1401.9228942408265, 1421.6090575091932, 1441.7981482592445, 801.4309840013656, 830.8670612701939, 843.8143608406141, 891.3003292415423, 927.3601215161517, 4556.658250631216, 5025.296458495814, 5404.32445944257, 5614.101743720985, 5660.462256085665, 5478.808241711521, 5917.668524581934, 5944.702764861826, 5992.490638295706, 6012.669303188367, 4864.902701946012, 5062.582476906472, 5343.545798607084, 5604.635698679573, 5616.943830561724, 2500.1874390823054, 2790.9952417129816, 3046.3754930239693, 3076.2926575750676, 3108.564800927872, 4337.570960262263, 5661.433856614306, 5926.140709597084, 6020.638761674313, 6161.8266592704795, 5121.103806833789, 5372.462753724674, 6025.246844144482, 6065.239551478112, 6120.41856023686, 4966.950330496648, 6064.393560643988, 6135.202423684892, 6149.354317796567, 6213.689315534296, 4785.545373189541, 5710.3990626645345, 5734.587920187481, 5850.7074646266665, 5939.46544810969, 5308.654937429054, 5570.554355651457, 5835.56233282514, 5880.8235752927485, 5939.732712027882, 5594.356648985256, 5955.166276721176, 6152.0, 6201.658908760061, 6212.534059945612, 3220.565223694865, 3796.5952597539085, 3823.617638236154, 3857.864974725871, 4056.8174432150035, 5241.9737901310245, 5650.943490565206, 5815.273090863642, 5903.173555702119, 5913.46778789911, 5150.278960945396, 5588.636738611977, 5811.389804070681, 5824.504917081926, 5871.559633027455, 4549.545045495424, 4648.0, 4674.742889140994, 4894.2169252920785, 5724.685142317213, 5404.378496472798, 5616.494515493625, 5643.4886475518, 5679.35298763354, 5698.914516282342, 4763.499832517536, 5683.2895888014, 5731.828045158652, 5815.651060936358, 5903.852403689943, 5279.656822306538, 5749.04532458966, 5754.338251101177, 5756.971215143897, 5766.94233057664], "value": 4187.474264679483, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [637.2225884421008, 740.3965767899161, 806.8265322955564, 824.5300178898027, 845.6067928413287, 16176.0, 16818.579535511588, 16834.66330673386, 16835.15824208789, 16847.49457516275, 15023.849761502383, 15087.62280942977, 15121.395144194219, 15137.772933406008, 15140.0, 724.5652608434949, 751.4439314906957, 753.815315247765, 755.2485277149244, 886.8004698942734, 736.0909277042848, 742.2948199210745, 880.6697488441835, 915.0940568836837, 921.8525035994243, 963.6434519227895, 975.9801007946712, 980.7989362180735, 982.076847763104, 983.5918093990986, 963.4412041016229, 964.0793042644258, 965.0928127560142, 968.0126271203403, 968.2012339819642, 721.3183541553234, 722.6242353975956, 723.6562632749454, 723.8009547374462, 723.9927600723978, 15227.238638068164, 15474.5357639271, 15501.147436891079, 15527.45653902108, 15540.61148471286, 13462.730745385037, 13685.863141368558, 13692.65768355799, 13905.582832515041, 14042.578722638234, 12899.29053902035, 13322.467101315935, 13348.0, 13454.394552245172, 13493.2578708171, 4662.95337046632, 4767.7616119194245, 4799.784009719571, 4870.0746858096845, 4958.454569997298, 128303.0, 129699.35150324283, 132824.0, 134750.32624836912, 134902.3254883729, 11101.611443599435, 11410.885891140982, 11411.771764564663, 11424.0, 11443.370614616277, 22780.0, 23302.76697233006, 23323.88338058299, 23325.0, 23330.0, 8305.044919834296, 8368.288695460833, 8386.245237928615, 8432.494050356998, 8478.321734261244, 4567.954320456819, 4705.205579992979, 4718.386609740781, 4747.881302967454, 4755.453122890843, 3533.94699079514, 3673.4673472346362, 3674.375356189454, 3677.099110717891, 3685.0787303174206, 669.3808227389645, 682.5392859819602, 684.5174152222671, 703.6516924122592, 704.1831475488511, 589.3016775121495, 591.9378465261171, 624.9906251406233, 632.2855173653742, 713.9286071392819, 8442.451240669337, 9066.863997040049, 9194.03462636427, 9284.210842078364, 9597.568109435093, 544.4473859033085, 621.9004959206505, 662.5060488598181, 663.7577284291199, 663.8074958262147, 4312.482502099705, 4503.662225333048, 4590.648088560275, 4617.422822147231, 4700.130475861976, 77048.0, 138354.0, 144116.27941860224, 150693.24653376662, 151390.0, 123372.38313808553, 128154.71845281615, 129578.35210824074, 134026.0, 136819.0, 77140.0, 104929.47535262427, 105276.0, 110271.0, 112603.0, 9976.750581235527, 10218.182545396201, 10264.0, 10313.9484302578, 10384.915007090969, 45911.77044114892, 62101.0, 62895.0, 63791.76728814469, 64390.0, 88970.66544001715, 91488.0, 92916.0, 97616.0, 100276.49861750644, 13085.280309583064, 13192.274424906338, 13404.262765547599, 13973.650658733613, 14265.42938282457, 15203.31585078652, 15680.607984800472, 16227.675446490768, 16400.589985250463, 16732.58168545796, 12271.69320766988, 13763.518276860263, 14079.296035198404, 14813.851861481678, 15314.38742450334, 14169.149851008973, 14437.85562144407, 14551.199684017482, 14704.55886323412, 14734.0, 11677.868339802742, 13095.738085238432, 13350.065495415227, 13777.380017899019, 13924.651883702989, 11197.0, 11360.261582997078, 11470.0, 12026.579069732517, 12144.265568451267, 8226.753197404087, 10149.847752283575, 11832.822507662564, 11855.585054523395, 12041.578544750892], "value": 8099.0638601759965, "unit": "score"}], "name": "dromaeo_css", "value": 7545.104408144983, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 113.0, 113.0, 112.0, 112.0, 114.0, 112.0, 111.0, 113.0, 113.0], "value": 112.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 108.0, 108.0, 139.0, 107.0, 109.0, 107.0, 106.0, 136.0, 108.0], "value": 116.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 183.0, 184.0, 181.0, 183.0, 184.0, 185.0, 181.0, 183.0, 181.0], "value": 182.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 58.0, 58.0, 87.0, 59.0, 58.0, 59.0, 76.0, 103.0, 74.0], "value": 71.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 70.0, 92.0, 70.0, 69.0, 68.0, 92.0, 67.0, 69.0, 89.0], "value": 77.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 87.0, 84.0, 88.0, 83.0, 87.0, 85.0, 87.0, 84.0], "value": 85.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 94.0, 92.0, 94.0, 93.0, 92.0, 93.0, 94.0, 93.0], "value": 93.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 80.0, 87.0, 87.0, 98.0, 135.0, 136.0, 84.0, 86.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 53.0, 54.0, 52.0, 55.0, 58.0, 57.0, 55.0, 56.0, 56.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 65.0, 67.0, 75.0, 71.0, 67.0, 67.0, 68.0, 67.0, 69.0], "value": 68.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 77.0, 81.0, 79.0, 81.0, 81.0, 82.0, 81.0, 87.0, 89.0], "value": 82.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 138.0, 142.0, 136.0, 133.0, 134.0, 137.0, 136.0, 166.0, 146.0], "value": 140.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 158.0, 160.0, 161.0, 162.0, 160.0, 160.0, 160.0, 160.0, 160.0], "value": 160.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 63.0, 77.0, 81.0, 80.0, 78.0, 64.0, 66.0], "value": 70.4, "unit": "score"}], "name": "kraken", "value": 1413.2, "alertThreshold": 2.0}]} 02:41:29 INFO - Return code: 0 02:41:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:41:29 INFO - # TBPL SUCCESS # 02:41:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:41:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:41:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:41:29 INFO - 2017-01-05 02:41:29.821 screenresolution[1659:10245] starting screenresolution argv=screenresolution get 02:41:29 INFO - 2017-01-05 02:41:29.823 screenresolution[1659:10245] Display 0: 1600x1200x32@60 02:41:29 INFO - 2017-01-05 02:41:29.829 screenresolution[1660:10248] starting screenresolution argv=screenresolution list 02:41:29 INFO - Available Modes on Display 0 02:41:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:41:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:41:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:41:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:41:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:41:30 INFO - Intel Iris: 02:41:30 INFO - Chipset Model: Intel Iris 02:41:30 INFO - Type: GPU 02:41:30 INFO - Bus: Built-In 02:41:30 INFO - VRAM (Dynamic, Max): 1536 MB 02:41:30 INFO - Vendor: Intel (0x8086) 02:41:30 INFO - Device ID: 0x0a2e 02:41:30 INFO - Revision ID: 0x0009 02:41:30 INFO - Displays: 02:41:30 INFO - Display: 02:41:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:41:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:41:30 INFO - Display Serial Number: 1600x1200 60 02:41:30 INFO - Main Display: Yes 02:41:30 INFO - Mirror: Off 02:41:30 INFO - Online: Yes 02:41:30 INFO - Rotation: Supported 02:41:30 INFO - Return code: 0 02:41:30 INFO - Running post-action listener: _resource_record_post_action 02:41:30 INFO - [mozharness: 2017-01-05 10:41:30.067291Z] Finished run-tests step (success) 02:41:30 INFO - Running post-run listener: _resource_record_post_run 02:41:30 INFO - Total resource usage - Wall time: 1195s; CPU: 53.0%; Read bytes: 32463872; Write bytes: 496210432; Read time: 199; Write time: 1542 02:41:30 INFO - TinderboxPrint: CPU usage
53.5% 02:41:30 INFO - TinderboxPrint: I/O read bytes / time
32,463,872 / 199 02:41:30 INFO - TinderboxPrint: I/O write bytes / time
496,210,432 / 1,542 02:41:30 INFO - TinderboxPrint: CPU idle
2,224.2 (46.5%) 02:41:30 INFO - TinderboxPrint: CPU system
956.9 (20.0%) 02:41:30 INFO - TinderboxPrint: CPU user
1,600.6 (33.5%) 02:41:30 INFO - TinderboxPrint: Swap in / out
223,817,728 / 0 02:41:30 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 192684544; Write bytes: 189982720; Read time: 17546; Write time: 407 02:41:30 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 30411776; Write bytes: 294988288; Read time: 179; Write time: 1097 02:41:30 INFO - Running post-run listener: _upload_blobber_files 02:41:30 INFO - Blob upload gear active. 02:41:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:41:30 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:41:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:41:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:41:30 INFO - (blobuploader) - INFO - Open directory for files ... 02:41:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:41:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:41:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:41:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:41:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:41:32 INFO - (blobuploader) - INFO - Done attempting. 02:41:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:41:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:41:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:41:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:41:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:41:33 INFO - (blobuploader) - INFO - Done attempting. 02:41:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:41:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:41:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:41:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:41:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:41:35 INFO - (blobuploader) - INFO - Done attempting. 02:41:35 INFO - (blobuploader) - INFO - Iteration through files over. 02:41:35 INFO - Return code: 0 02:41:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:41:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:41:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ea0ff52a7406454123345141366e90d0d55fc6d7b49034f69eee92369292c91eaea197b599a705a0e2ba95e2daf0dd52232417e90e1d0c665de7d6681f10d5b5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/823e33b561387a7de9548b4b8a7ca0fd327ad8b16660da4faea77f8621e388cf57d2b362d80a7bccf67196daceb1753d677e80104cfa7a7774b82fd1578fa1df", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a14dc35ad02d8569ceee9d7705e7a2464f20d55955bc8d8488c43c9bb0756400f528527326964aaddcced3b0421758e3657f8aa775ec7ffeaa2456ccac690d11"} 02:41:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:41:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:41:35 INFO - Contents: 02:41:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ea0ff52a7406454123345141366e90d0d55fc6d7b49034f69eee92369292c91eaea197b599a705a0e2ba95e2daf0dd52232417e90e1d0c665de7d6681f10d5b5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/823e33b561387a7de9548b4b8a7ca0fd327ad8b16660da4faea77f8621e388cf57d2b362d80a7bccf67196daceb1753d677e80104cfa7a7774b82fd1578fa1df", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a14dc35ad02d8569ceee9d7705e7a2464f20d55955bc8d8488c43c9bb0756400f528527326964aaddcced3b0421758e3657f8aa775ec7ffeaa2456ccac690d11"} 02:41:35 INFO - Running post-run listener: copy_logs_to_upload_dir 02:41:35 INFO - Copying logs to upload dir... 02:41:35 INFO - mkdir: /builds/slave/test/build/upload/logs 02:41:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.641324 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-01-05 02:41:35.495502) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-05 02:41:35.498812) ========= 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.PHB5PjLgJy/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.SGrH7wtE0q/Listeners TMPDIR=/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/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/ea0ff52a7406454123345141366e90d0d55fc6d7b49034f69eee92369292c91eaea197b599a705a0e2ba95e2daf0dd52232417e90e1d0c665de7d6681f10d5b5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/823e33b561387a7de9548b4b8a7ca0fd327ad8b16660da4faea77f8621e388cf57d2b362d80a7bccf67196daceb1753d677e80104cfa7a7774b82fd1578fa1df", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a14dc35ad02d8569ceee9d7705e7a2464f20d55955bc8d8488c43c9bb0756400f528527326964aaddcced3b0421758e3657f8aa775ec7ffeaa2456ccac690d11"} build_url:https://queue.taskcluster.net/v1/task/Fbq2a7hUTlW7PaAMin4ojQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011162 build_url: 'https://queue.taskcluster.net/v1/task/Fbq2a7hUTlW7PaAMin4ojQ/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/ea0ff52a7406454123345141366e90d0d55fc6d7b49034f69eee92369292c91eaea197b599a705a0e2ba95e2daf0dd52232417e90e1d0c665de7d6681f10d5b5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/823e33b561387a7de9548b4b8a7ca0fd327ad8b16660da4faea77f8621e388cf57d2b362d80a7bccf67196daceb1753d677e80104cfa7a7774b82fd1578fa1df", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a14dc35ad02d8569ceee9d7705e7a2464f20d55955bc8d8488c43c9bb0756400f528527326964aaddcced3b0421758e3657f8aa775ec7ffeaa2456ccac690d11"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-05 02:41:35.534376) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 02:41:35.534725) ========= 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.PHB5PjLgJy/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.SGrH7wtE0q/Listeners TMPDIR=/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/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.005149 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 02:41:35.583964) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-05 02:41:35.584297) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-05 02:41:35.584673) ========= ========= Total master_lag: 0.22 =========