builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0183 starttime: 1486224162.09 results: success (0) buildid: 20170204072708 builduid: 140e550e907c409793315b3ecdcb7666 revision: f8d696a34c172ce8e118d5af0b0e7b7f4bb13105 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-04 08:02:42.087306) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-04 08:02:42.087802) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-04 08:02:42.088077) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-04 08:02:42.114699) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-04 08:02:42.115000) ========= 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.Wf35rKklya/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.Arqgkmi4CW/Listeners TMPDIR=/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/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-02-04 08:02:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 171M=0s 2017-02-04 08:02:42 (171 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.588086 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-04 08:02:42.726958) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-04 08:02:42.730319) ========= 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.Wf35rKklya/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.Arqgkmi4CW/Listeners TMPDIR=/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/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.026569 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-04 08:02:42.778905) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-04 08:02:42.782272) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f8d696a34c172ce8e118d5af0b0e7b7f4bb13105 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev f8d696a34c172ce8e118d5af0b0e7b7f4bb13105 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Wf35rKklya/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.Arqgkmi4CW/Listeners TMPDIR=/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/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-02-04 08:02:42,882 truncating revision to first 12 chars 2017-02-04 08:02:42,882 Setting DEBUG logging. 2017-02-04 08:02:42,883 attempt 1/10 2017-02-04 08:02:42,883 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f8d696a34c17?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-04 08:02:44,414 unpacking tar archive at: mozilla-central-f8d696a34c17/testing/mozharness/ program finished with exit code 0 elapsedTime=1.813393 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-04 08:02:44.618439) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-04 08:02:44.618722) ========= script_repo_revision: f8d696a34c172ce8e118d5af0b0e7b7f4bb13105 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-04 08:02:44.619079) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-04 08:02:44.622507) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-04 08:02:44.711430) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-02-04 08:02:44.711750) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Wf35rKklya/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.Arqgkmi4CW/Listeners TMPDIR=/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 08:02:44 INFO - MultiFileLogger online at 20170204 08:02:44 in /builds/slave/test 08:02:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 08:02:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:02:44 INFO - {'append_to_log': False, 08:02:44 INFO - 'base_work_dir': '/builds/slave/test', 08:02:44 INFO - 'blob_upload_branch': 'Firefox', 08:02:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:02:44 INFO - 'branch': 'Firefox', 08:02:44 INFO - 'buildbot_json_path': 'buildprops.json', 08:02:44 INFO - 'config_files': ('talos/mac_config.py',), 08:02:44 INFO - 'default_actions': ('clobber', 08:02:44 INFO - 'read-buildbot-config', 08:02:44 INFO - 'download-and-extract', 08:02:44 INFO - 'populate-webroot', 08:02:44 INFO - 'create-virtualenv', 08:02:44 INFO - 'install', 08:02:44 INFO - 'run-tests'), 08:02:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:02:44 INFO - 'download_minidump_stackwalk': True, 08:02:44 INFO - 'download_symbols': 'ondemand', 08:02:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:02:44 INFO - 'tooltool.py': '/tools/tooltool.py', 08:02:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:02:44 INFO - '/tools/misc-python/virtualenv.py')}, 08:02:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:02:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:02:44 INFO - 'installer_path': 'installer.exe', 08:02:44 INFO - 'log_level': 'info', 08:02:44 INFO - 'log_name': 'talos', 08:02:44 INFO - 'log_to_console': True, 08:02:44 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:02:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:02:44 INFO - 'opt_config_files': (), 08:02:44 INFO - 'pip_index': False, 08:02:44 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:02:44 INFO - 'cmd': ('bash', 08:02:44 INFO - '-c', 08:02:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:02:44 INFO - 'enabled': True, 08:02:44 INFO - 'halt_on_failure': False, 08:02:44 INFO - 'name': 'check_screen_resolution'},), 08:02:44 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:02:44 INFO - 'cmd': ('bash', 08:02:44 INFO - '-c', 08:02:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:02:44 INFO - 'enabled': True, 08:02:44 INFO - 'halt_on_failure': False, 08:02:44 INFO - 'name': 'check_screen_resolution'},), 08:02:44 INFO - 'run_cmd_checks_enabled': True, 08:02:44 INFO - 'sps_profile': False, 08:02:44 INFO - 'sps_profile_interval': 0, 08:02:44 INFO - 'suite': 'dromaeojs', 08:02:44 INFO - 'system_bits': '32', 08:02:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:02:44 INFO - 'title': 't-yosemite-r7-0183', 08:02:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:02:44 INFO - 'use_talos_json': True, 08:02:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:02:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:02:44 INFO - 'work_dir': 'build'} 08:02:44 INFO - [mozharness: 2017-02-04 16:02:44.926346Z] Running clobber step. 08:02:44 INFO - Running pre-action listener: _resource_record_pre_action 08:02:44 INFO - Running main action method: clobber 08:02:44 INFO - rmtree: /builds/slave/test/build 08:02:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:02:47 INFO - Running post-action listener: _resource_record_post_action 08:02:47 INFO - [mozharness: 2017-02-04 16:02:47.495103Z] Finished clobber step (success) 08:02:47 INFO - [mozharness: 2017-02-04 16:02:47.495279Z] Running read-buildbot-config step. 08:02:47 INFO - Running pre-action listener: _resource_record_pre_action 08:02:47 INFO - Running main action method: read_buildbot_config 08:02:47 INFO - Using buildbot properties: 08:02:47 INFO - { 08:02:47 INFO - "project": "", 08:02:47 INFO - "product": "firefox", 08:02:47 INFO - "script_repo_revision": "production", 08:02:47 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 08:02:47 INFO - "repository": "", 08:02:47 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 08:02:47 INFO - "buildid": "20170204072708", 08:02:47 INFO - "pgo_build": "False", 08:02:47 INFO - "basedir": "/builds/slave/test", 08:02:47 INFO - "buildnumber": 65, 08:02:47 INFO - "slavename": "t-yosemite-r7-0183", 08:02:47 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 08:02:47 INFO - "platform": "yosemite_r7", 08:02:47 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 08:02:47 INFO - "branch": "mozilla-central", 08:02:47 INFO - "repo_path": "mozilla-central", 08:02:47 INFO - "revision": "f8d696a34c172ce8e118d5af0b0e7b7f4bb13105", 08:02:47 INFO - "stage_platform": "macosx64", 08:02:47 INFO - "builduid": "140e550e907c409793315b3ecdcb7666", 08:02:47 INFO - "slavebuilddir": "test" 08:02:47 INFO - } 08:02:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/MX7yl3euQSaS67FMgKiaIA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 08:02:47 INFO - Running post-action listener: _resource_record_post_action 08:02:47 INFO - [mozharness: 2017-02-04 16:02:47.499341Z] Finished read-buildbot-config step (success) 08:02:47 INFO - [mozharness: 2017-02-04 16:02:47.499487Z] Running download-and-extract step. 08:02:47 INFO - Running pre-action listener: _resource_record_pre_action 08:02:47 INFO - Running main action method: download_and_extract 08:02:47 INFO - mkdir: /builds/slave/test/build/tests 08:02:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:02:47 INFO - trying https://queue.taskcluster.net/v1/task/MX7yl3euQSaS67FMgKiaIA/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 08:02:47 INFO - Downloading https://queue.taskcluster.net/v1/task/MX7yl3euQSaS67FMgKiaIA/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 08:02:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MX7yl3euQSaS67FMgKiaIA/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 08:02:48 INFO - Downloaded 1199 bytes. 08:02:48 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 08:02:48 INFO - Using the following test package requirements: 08:02:48 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 08:02:48 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 08:02:48 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 08:02:48 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 08:02:48 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 08:02:48 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 08:02:48 INFO - u'jsshell-mac.zip'], 08:02:48 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 08:02:48 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 08:02:48 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 08:02:48 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 08:02:48 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 08:02:48 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 08:02:48 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 08:02:48 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 08:02:48 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 08:02:48 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 08:02:48 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 08:02:48 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:02:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MX7yl3euQSaS67FMgKiaIA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 08:02:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MX7yl3euQSaS67FMgKiaIA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:02:48 INFO - Fetch https://queue.taskcluster.net/v1/task/MX7yl3euQSaS67FMgKiaIA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 08:02:49 INFO - Expected file size: 34850859 08:02:49 INFO - Obtained file size: 34850859 08:02:56 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 08:02:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MX7yl3euQSaS67FMgKiaIA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 08:02:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MX7yl3euQSaS67FMgKiaIA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:02:56 INFO - Fetch https://queue.taskcluster.net/v1/task/MX7yl3euQSaS67FMgKiaIA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 08:02:57 INFO - Expected file size: 34850859 08:02:57 INFO - Obtained file size: 34850859 08:03:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MX7yl3euQSaS67FMgKiaIA/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 08:03:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MX7yl3euQSaS67FMgKiaIA/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 08:03:04 INFO - Fetch https://queue.taskcluster.net/v1/task/MX7yl3euQSaS67FMgKiaIA/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 08:03:05 INFO - Expected file size: 14403454 08:03:05 INFO - Obtained file size: 14403454 08:03: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')]} 08:03:05 INFO - trying https://queue.taskcluster.net/v1/task/MX7yl3euQSaS67FMgKiaIA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 08:03:05 INFO - Downloading https://queue.taskcluster.net/v1/task/MX7yl3euQSaS67FMgKiaIA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 08:03:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MX7yl3euQSaS67FMgKiaIA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 08:03:08 INFO - Downloaded 70292082 bytes. 08:03:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MX7yl3euQSaS67FMgKiaIA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 08:03:08 INFO - mkdir: /builds/slave/test/properties 08:03:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:03:08 INFO - Writing to file /builds/slave/test/properties/build_url 08:03:08 INFO - Contents: 08:03:08 INFO - build_url:https://queue.taskcluster.net/v1/task/MX7yl3euQSaS67FMgKiaIA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 08:03:08 INFO - Running post-action listener: _resource_record_post_action 08:03:08 INFO - Running post-action listener: set_extra_try_arguments 08:03:08 INFO - [mozharness: 2017-02-04 16:03:08.916260Z] Finished download-and-extract step (success) 08:03:08 INFO - [mozharness: 2017-02-04 16:03:08.916373Z] Running populate-webroot step. 08:03:08 INFO - Running pre-action listener: _resource_record_pre_action 08:03:08 INFO - Running main action method: populate_webroot 08:03:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:03:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:03:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:03:08 INFO - '--tppagecycles', 08:03:08 INFO - '7'], 08:03:08 INFO - 'tests': ['tsvgm']}}, 08:03:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:03:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:03:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:03:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:03:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:03:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:03:08 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:03:08 INFO - 'talos_options': ['--disable-e10s'], 08:03:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:03:08 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:03:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:03:08 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:03:08 INFO - 'talos_options': ['--disable-e10s'], 08:03:08 INFO - 'tests': ['damp', 'tps']}, 08:03:08 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:03:08 INFO - 'tests': ['damp', 'tps']}, 08:03:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:03:08 INFO - 'tests': ['dromaeo_dom']}, 08:03:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:03:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:03:08 INFO - 'tests': ['basic_compositor_video']}, 08:03:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:03:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:03:08 INFO - 'tests': ['a11yr', 08:03:08 INFO - 'ts_paint', 08:03:08 INFO - 'tpaint', 08:03:08 INFO - 'sessionrestore', 08:03:08 INFO - 'sessionrestore_no_auto_restore', 08:03:08 INFO - 'tabpaint']}, 08:03:08 INFO - 'other-e10s': {'tests': ['a11yr', 08:03:08 INFO - 'ts_paint', 08:03:08 INFO - 'tpaint', 08:03:08 INFO - 'sessionrestore', 08:03:08 INFO - 'sessionrestore_no_auto_restore', 08:03:08 INFO - 'tabpaint']}, 08:03:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:03:08 INFO - 'ts_paint', 08:03:08 INFO - 'tpaint', 08:03:08 INFO - 'sessionrestore', 08:03:08 INFO - 'sessionrestore_no_auto_restore', 08:03:08 INFO - 'tabpaint']}, 08:03:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:03:08 INFO - 'ts_paint', 08:03:08 INFO - 'tpaint', 08:03:08 INFO - 'sessionrestore', 08:03:08 INFO - 'sessionrestore_no_auto_restore', 08:03:08 INFO - 'tabpaint']}, 08:03:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:03:08 INFO - 'tests': ['a11yr', 08:03:08 INFO - 'ts_paint', 08:03:08 INFO - 'tpaint', 08:03:08 INFO - 'sessionrestore', 08:03:08 INFO - 'sessionrestore_no_auto_restore', 08:03:08 INFO - 'tabpaint']}, 08:03:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:03:08 INFO - 'tests': ['a11yr', 08:03:08 INFO - 'ts_paint', 08:03:08 INFO - 'tpaint', 08:03:08 INFO - 'sessionrestore', 08:03:08 INFO - 'sessionrestore_no_auto_restore', 08:03:08 INFO - 'tabpaint']}, 08:03:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:03:08 INFO - 'tests': ['tsvgx', 08:03:08 INFO - 'tsvgr_opacity', 08:03:08 INFO - 'tart', 08:03:08 INFO - 'tscrollx', 08:03:08 INFO - 'cart', 08:03:08 INFO - 'tsvg_static']}, 08:03:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:03:08 INFO - 'tsvgr_opacity', 08:03:08 INFO - 'tart', 08:03:08 INFO - 'tscrollx', 08:03:08 INFO - 'cart', 08:03:08 INFO - 'tsvg_static']}, 08:03:08 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:03:08 INFO - 'talos_options': ['--disable-e10s'], 08:03:08 INFO - 'tests': ['tp5o']}, 08:03:08 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:03:08 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:03:08 INFO - 'talos_options': ['--disable-e10s', 08:03:08 INFO - '--xperf_path', 08:03:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:03:08 INFO - 'tests': ['tp5n']}, 08:03:08 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:03:08 INFO - 'talos_options': ['--xperf_path', 08:03:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:03:08 INFO - 'tests': ['tp5n']}}, 08:03:08 INFO - 'talos.zip': {'path': '', 08:03:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:03:08 INFO - Running post-action listener: _resource_record_post_action 08:03:08 INFO - [mozharness: 2017-02-04 16:03:08.934981Z] Finished populate-webroot step (success) 08:03:08 INFO - [mozharness: 2017-02-04 16:03:08.935121Z] Running create-virtualenv step. 08:03:08 INFO - Running pre-action listener: _resource_record_pre_action 08:03:08 INFO - Running main action method: create_virtualenv 08:03:08 INFO - Creating virtualenv /builds/slave/test/build/venv 08:03:08 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:03:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:03:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:03:09 INFO - Using real prefix '/tools/python27' 08:03:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:03:09 INFO - Installing distribute.............................................................................................................................................................................................done. 08:03:12 INFO - Installing pip.................done. 08:03:12 INFO - Return code: 0 08:03:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:03:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:03:12 INFO - Reading from file tmpfile_stdout 08:03:12 INFO - Output received: 08:03:12 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:03:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:03:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:03:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:03:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:12 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 0x105c4eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c51768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3924ca530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a2cd30>, '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 0x105953db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a21be8>, '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.Wf35rKklya/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.Arqgkmi4CW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:03:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:03:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:03:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Wf35rKklya/Render', 08:03:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:03:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:03:12 INFO - 'HOME': '/Users/cltbld', 08:03:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:03:12 INFO - 'LOGNAME': 'cltbld', 08:03:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:12 INFO - 'MOZ_NO_REMOTE': '1', 08:03:12 INFO - 'NO_EM_RESTART': '1', 08:03:12 INFO - 'PAGER': '/bin/cat', 08:03:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:03:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:12 INFO - 'PWD': '/builds/slave/test', 08:03:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:03:12 INFO - 'SHELL': '/bin/bash', 08:03:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Arqgkmi4CW/Listeners', 08:03:12 INFO - 'TMPDIR': '/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/', 08:03:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:03:12 INFO - 'USER': 'cltbld', 08:03:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:03:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:03:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:12 INFO - 'XPC_FLAGS': '0x0', 08:03:12 INFO - 'XPC_SERVICE_NAME': '0', 08:03:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:03:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:03:13 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:03:13 INFO - Cleaning up... 08:03:13 INFO - Return code: 0 08:03:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:03:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:03:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:03:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:13 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 0x105c4eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c51768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3924ca530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a2cd30>, '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 0x105953db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a21be8>, '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.Wf35rKklya/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.Arqgkmi4CW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:03:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:03:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:03:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Wf35rKklya/Render', 08:03:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:03:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:03:13 INFO - 'HOME': '/Users/cltbld', 08:03:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:03:13 INFO - 'LOGNAME': 'cltbld', 08:03:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:13 INFO - 'MOZ_NO_REMOTE': '1', 08:03:13 INFO - 'NO_EM_RESTART': '1', 08:03:13 INFO - 'PAGER': '/bin/cat', 08:03:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:03:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:13 INFO - 'PWD': '/builds/slave/test', 08:03:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:03:13 INFO - 'SHELL': '/bin/bash', 08:03:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Arqgkmi4CW/Listeners', 08:03:13 INFO - 'TMPDIR': '/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/', 08:03:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:03:13 INFO - 'USER': 'cltbld', 08:03:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:03:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:03:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:13 INFO - 'XPC_FLAGS': '0x0', 08:03:13 INFO - 'XPC_SERVICE_NAME': '0', 08:03:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:03:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:03:13 INFO - Downloading/unpacking psutil>=3.1.1 08:03:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:03:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:03:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:03:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:03:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:03:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:03:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:03:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:03:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:03:17 INFO - Installing collected packages: psutil 08:03:17 INFO - Running setup.py install for psutil 08:03:17 INFO - building 'psutil._psutil_osx' extension 08:03:17 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 08:03:18 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 08:03:18 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 08:03:18 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 08:03:18 INFO - building 'psutil._psutil_posix' extension 08:03:18 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 08:03:18 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:03:18 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:03:18 INFO - ^ 08:03:18 INFO - 1 warning generated. 08:03:18 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 08:03:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:03:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:03:18 INFO - Successfully installed psutil 08:03:18 INFO - Cleaning up... 08:03:18 INFO - Return code: 0 08:03:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:03: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')]} 08:03:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:03:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03: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')]} 08:03:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:03:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105c4eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c51768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3924ca530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a2cd30>, '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 0x105953db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a21be8>, '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.Wf35rKklya/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.Arqgkmi4CW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:03: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:03: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 mozsystemmonitor==0.3 08:03:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Wf35rKklya/Render', 08:03:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:03:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:03:18 INFO - 'HOME': '/Users/cltbld', 08:03:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:03:18 INFO - 'LOGNAME': 'cltbld', 08:03:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:18 INFO - 'MOZ_NO_REMOTE': '1', 08:03:18 INFO - 'NO_EM_RESTART': '1', 08:03:18 INFO - 'PAGER': '/bin/cat', 08:03:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:03:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:18 INFO - 'PWD': '/builds/slave/test', 08:03:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:03:18 INFO - 'SHELL': '/bin/bash', 08:03:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Arqgkmi4CW/Listeners', 08:03:18 INFO - 'TMPDIR': '/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/', 08:03:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:03:18 INFO - 'USER': 'cltbld', 08:03:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:03:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:03:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:18 INFO - 'XPC_FLAGS': '0x0', 08:03:18 INFO - 'XPC_SERVICE_NAME': '0', 08:03:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:03:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:03:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:03:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:03:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:03:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:03:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:03:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:03:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:03:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:03:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:03:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:03:21 INFO - Installing collected packages: mozsystemmonitor 08:03:21 INFO - Running setup.py install for mozsystemmonitor 08:03:21 INFO - Successfully installed mozsystemmonitor 08:03:21 INFO - Cleaning up... 08:03:21 INFO - Return code: 0 08:03:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:03:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:03:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:03:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:21 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 0x105c4eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c51768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3924ca530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a2cd30>, '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 0x105953db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a21be8>, '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.Wf35rKklya/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.Arqgkmi4CW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:03:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:03:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:03:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Wf35rKklya/Render', 08:03:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:03:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:03:21 INFO - 'HOME': '/Users/cltbld', 08:03:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:03:21 INFO - 'LOGNAME': 'cltbld', 08:03:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:21 INFO - 'MOZ_NO_REMOTE': '1', 08:03:21 INFO - 'NO_EM_RESTART': '1', 08:03:21 INFO - 'PAGER': '/bin/cat', 08:03:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:03:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:21 INFO - 'PWD': '/builds/slave/test', 08:03:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:03:21 INFO - 'SHELL': '/bin/bash', 08:03:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Arqgkmi4CW/Listeners', 08:03:21 INFO - 'TMPDIR': '/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/', 08:03:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:03:21 INFO - 'USER': 'cltbld', 08:03:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:03:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:03:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:21 INFO - 'XPC_FLAGS': '0x0', 08:03:21 INFO - 'XPC_SERVICE_NAME': '0', 08:03:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:03:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:03:22 INFO - Downloading/unpacking jsonschema==2.5.1 08:03: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 08:03: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 08:03: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 08:03: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 08:03: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 08:03: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 08:03:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:03:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:03:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:03:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:03:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:03:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:03:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:03:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:03:25 INFO - Downloading functools32-3.2.3-2.tar.gz 08:03:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:03:25 INFO - warning: no files found matching '*.txt' 08:03:25 INFO - no previously-included directories found matching 'build' 08:03:25 INFO - no previously-included directories found matching 'dist' 08:03:25 INFO - no previously-included directories found matching '.git*' 08:03:25 INFO - Installing collected packages: jsonschema, functools32 08:03:25 INFO - Running setup.py install for functools32 08:03:25 INFO - warning: no files found matching '*.txt' 08:03:25 INFO - no previously-included directories found matching 'build' 08:03:25 INFO - no previously-included directories found matching 'dist' 08:03:25 INFO - no previously-included directories found matching '.git*' 08:03:25 INFO - Successfully installed jsonschema functools32 08:03:25 INFO - Cleaning up... 08:03:25 INFO - Return code: 0 08:03:25 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:03:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:03:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:03:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:25 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 0x105c4eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c51768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3924ca530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a2cd30>, '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 0x105953db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a21be8>, '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.Wf35rKklya/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.Arqgkmi4CW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:03:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:03:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:03:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Wf35rKklya/Render', 08:03:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:03:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:03:25 INFO - 'HOME': '/Users/cltbld', 08:03:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:03:25 INFO - 'LOGNAME': 'cltbld', 08:03:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:25 INFO - 'MOZ_NO_REMOTE': '1', 08:03:25 INFO - 'NO_EM_RESTART': '1', 08:03:25 INFO - 'PAGER': '/bin/cat', 08:03:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:03:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:25 INFO - 'PWD': '/builds/slave/test', 08:03:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:03:25 INFO - 'SHELL': '/bin/bash', 08:03:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Arqgkmi4CW/Listeners', 08:03:25 INFO - 'TMPDIR': '/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/', 08:03:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:03:25 INFO - 'USER': 'cltbld', 08:03:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:03:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:03:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:25 INFO - 'XPC_FLAGS': '0x0', 08:03:25 INFO - 'XPC_SERVICE_NAME': '0', 08:03:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:03:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:03:25 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:03:25 INFO - Cleaning up... 08:03:25 INFO - Return code: 0 08:03:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:03:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:03:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:03:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:25 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 0x105c4eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c51768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3924ca530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a2cd30>, '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 0x105953db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a21be8>, '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.Wf35rKklya/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.Arqgkmi4CW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:03:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:03:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:03:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Wf35rKklya/Render', 08:03:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:03:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:03:25 INFO - 'HOME': '/Users/cltbld', 08:03:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:03:25 INFO - 'LOGNAME': 'cltbld', 08:03:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:25 INFO - 'MOZ_NO_REMOTE': '1', 08:03:25 INFO - 'NO_EM_RESTART': '1', 08:03:25 INFO - 'PAGER': '/bin/cat', 08:03:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:03:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:25 INFO - 'PWD': '/builds/slave/test', 08:03:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:03:25 INFO - 'SHELL': '/bin/bash', 08:03:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Arqgkmi4CW/Listeners', 08:03:25 INFO - 'TMPDIR': '/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/', 08:03:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:03:25 INFO - 'USER': 'cltbld', 08:03:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:03:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:03:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:25 INFO - 'XPC_FLAGS': '0x0', 08:03:25 INFO - 'XPC_SERVICE_NAME': '0', 08:03:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:03:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:03:26 INFO - Downloading/unpacking blobuploader==1.2.4 08:03:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:03:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:03:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:03:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:03:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:03:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:03:28 INFO - Downloading blobuploader-1.2.4.tar.gz 08:03:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:03:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:03:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:03:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:03:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:03:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:03:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:03:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:03:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:03:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:03:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:03:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:03:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:03:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:03:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:03:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:03:29 INFO - Downloading docopt-0.6.1.tar.gz 08:03:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:03:30 INFO - Installing collected packages: blobuploader, requests, docopt 08:03:30 INFO - Running setup.py install for blobuploader 08:03:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:03:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:03:30 INFO - Running setup.py install for requests 08:03:30 INFO - Running setup.py install for docopt 08:03:30 INFO - Successfully installed blobuploader requests docopt 08:03:30 INFO - Cleaning up... 08:03:30 INFO - Return code: 0 08:03:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:03:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:03:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:03:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:30 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 0x105c4eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c51768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3924ca530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a2cd30>, '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 0x105953db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a21be8>, '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.Wf35rKklya/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.Arqgkmi4CW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:03:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:03:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:03:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Wf35rKklya/Render', 08:03:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:03:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:03:30 INFO - 'HOME': '/Users/cltbld', 08:03:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:03:30 INFO - 'LOGNAME': 'cltbld', 08:03:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:30 INFO - 'MOZ_NO_REMOTE': '1', 08:03:30 INFO - 'NO_EM_RESTART': '1', 08:03:30 INFO - 'PAGER': '/bin/cat', 08:03:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:03:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:30 INFO - 'PWD': '/builds/slave/test', 08:03:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:03:30 INFO - 'SHELL': '/bin/bash', 08:03:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Arqgkmi4CW/Listeners', 08:03:30 INFO - 'TMPDIR': '/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/', 08:03:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:03:30 INFO - 'USER': 'cltbld', 08:03:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:03:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:03:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:30 INFO - 'XPC_FLAGS': '0x0', 08:03:30 INFO - 'XPC_SERVICE_NAME': '0', 08:03:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:03:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:03:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:03:31 INFO - Running setup.py (path:/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/pip-mfA7UO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:03:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:03:31 INFO - Running setup.py (path:/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/pip-Be9RCs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:03:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:03:31 INFO - Running setup.py (path:/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/pip-T2q6UX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:03:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:03:31 INFO - Running setup.py (path:/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/pip-YwKkBx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:03:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:03:31 INFO - Running setup.py (path:/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/pip-3af9HV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:03:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:03:31 INFO - Running setup.py (path:/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/pip-De4bEJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:03:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:03:31 INFO - Running setup.py (path:/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/pip-YolCM4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:03:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:03:31 INFO - Running setup.py (path:/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/pip-giNgtK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:03:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:03:32 INFO - Running setup.py (path:/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/pip-Qwe01O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:03:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:03:32 INFO - Running setup.py (path:/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/pip-U5yZhn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:03:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:03:32 INFO - Running setup.py (path:/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/pip-7tkUH3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:03:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:03:32 INFO - Running setup.py (path:/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/pip-FrfkZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:03:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:03:32 INFO - Running setup.py (path:/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/pip-YNgj_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:03:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:03:32 INFO - Running setup.py (path:/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/pip-CrjUbi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:03:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:03:32 INFO - Running setup.py (path:/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/pip-dRKPwN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:03:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:03:32 INFO - Running setup.py (path:/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/pip-3PoPo0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:03:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:03:32 INFO - Running setup.py (path:/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/pip-oAqNcw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:03:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:03:32 INFO - Running setup.py install for manifestparser 08:03:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:03:33 INFO - Running setup.py install for mozcrash 08:03:33 INFO - Running setup.py install for mozdebug 08:03:33 INFO - Running setup.py install for mozdevice 08:03:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:03:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:03:33 INFO - Running setup.py install for mozfile 08:03:33 INFO - Running setup.py install for mozhttpd 08:03:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:03:33 INFO - Running setup.py install for mozinfo 08:03:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:03:33 INFO - Running setup.py install for mozInstall 08:03:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:03:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:03:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:03:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:03:34 INFO - Running setup.py install for mozleak 08:03:34 INFO - Running setup.py install for mozlog 08:03:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:03:34 INFO - Running setup.py install for moznetwork 08:03:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:03:34 INFO - Running setup.py install for mozprocess 08:03:34 INFO - Running setup.py install for mozprofile 08:03:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:03:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:03:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:03:34 INFO - Running setup.py install for mozrunner 08:03:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:03:35 INFO - Running setup.py install for mozscreenshot 08:03:35 INFO - Running setup.py install for moztest 08:03:35 INFO - Running setup.py install for mozversion 08:03:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:03:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:03:35 INFO - Cleaning up... 08:03:35 INFO - Return code: 0 08:03:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:03:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:03:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:03:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:35 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 0x105c4eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c51768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3924ca530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a2cd30>, '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 0x105953db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a21be8>, '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.Wf35rKklya/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.Arqgkmi4CW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:03:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:03:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:03:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Wf35rKklya/Render', 08:03:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:03:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:03:35 INFO - 'HOME': '/Users/cltbld', 08:03:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:03:35 INFO - 'LOGNAME': 'cltbld', 08:03:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:35 INFO - 'MOZ_NO_REMOTE': '1', 08:03:35 INFO - 'NO_EM_RESTART': '1', 08:03:35 INFO - 'PAGER': '/bin/cat', 08:03:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:03:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:35 INFO - 'PWD': '/builds/slave/test', 08:03:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:03:35 INFO - 'SHELL': '/bin/bash', 08:03:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Arqgkmi4CW/Listeners', 08:03:35 INFO - 'TMPDIR': '/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/', 08:03:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:03:35 INFO - 'USER': 'cltbld', 08:03:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:03:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:03:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:35 INFO - 'XPC_FLAGS': '0x0', 08:03:35 INFO - 'XPC_SERVICE_NAME': '0', 08:03:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:03:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:03:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:03:35 INFO - Running setup.py (path:/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/pip-aTbgmg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:03:35 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:03:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:03:35 INFO - Running setup.py (path:/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/pip-bTmoIO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:03:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:03:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:03:36 INFO - Running setup.py (path:/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/pip-O_p0SF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:03:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:03:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:03:36 INFO - Running setup.py (path:/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/pip-Sz6rIY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:03:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:03:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:03:36 INFO - Running setup.py (path:/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/pip-iHaGD5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:03:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:03:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:03:36 INFO - Running setup.py (path:/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/pip-hYPZ0r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:03:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:03:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:03:36 INFO - Running setup.py (path:/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/pip-S2pVBk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:03:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:03:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:03:36 INFO - Running setup.py (path:/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/pip-CMBUSp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:03:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:03:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:03:36 INFO - Running setup.py (path:/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/pip-G1SZSt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:03:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:03:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:03:36 INFO - Running setup.py (path:/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/pip-orQXZ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:03:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:03:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:03:36 INFO - Running setup.py (path:/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/pip-EUCSyH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:03:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:03:37 INFO - Running setup.py (path:/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/pip-WNTtpr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:03:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:03:37 INFO - Running setup.py (path:/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/pip-spkDNv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:03:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:03:37 INFO - Running setup.py (path:/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/pip-JJPQZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:03:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:03:37 INFO - Running setup.py (path:/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/pip-AHOEc0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:03:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:03:37 INFO - Running setup.py (path:/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/pip-Y_GJ_k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:03:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:03:37 INFO - Running setup.py (path:/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/pip-AvBbe0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:03:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:03:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:03:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:03:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:03:37 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:03:37 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:03:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:03:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:03:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:03:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:03:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:03:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:03:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:03:40 INFO - Downloading blessings-1.6.tar.gz 08:03:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:03:40 INFO - Installing collected packages: blessings 08:03:40 INFO - Running setup.py install for blessings 08:03:40 INFO - Successfully installed blessings 08:03:40 INFO - Cleaning up... 08:03:40 INFO - Return code: 0 08:03:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:03:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:03:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:03:40 INFO - Reading from file tmpfile_stdout 08:03:40 INFO - Current package versions: 08:03:40 INFO - blessings == 1.6 08:03:40 INFO - blobuploader == 1.2.4 08:03:40 INFO - docopt == 0.6.1 08:03:40 INFO - functools32 == 3.2.3-2 08:03:40 INFO - jsonschema == 2.5.1 08:03:40 INFO - manifestparser == 1.1 08:03:40 INFO - mozInstall == 1.12 08:03:40 INFO - mozcrash == 1.0 08:03:40 INFO - mozdebug == 0.1 08:03:40 INFO - mozdevice == 0.49 08:03:40 INFO - mozfile == 1.2 08:03:40 INFO - mozhttpd == 0.7 08:03:40 INFO - mozinfo == 0.9 08:03:40 INFO - mozleak == 0.1 08:03:40 INFO - mozlog == 3.4 08:03:40 INFO - moznetwork == 0.27 08:03:40 INFO - mozprocess == 0.24 08:03:40 INFO - mozprofile == 0.28 08:03:40 INFO - mozrunner == 6.13 08:03:40 INFO - mozscreenshot == 0.1 08:03:40 INFO - mozsystemmonitor == 0.3 08:03:40 INFO - moztest == 0.8 08:03:40 INFO - mozversion == 1.4 08:03:40 INFO - psutil == 3.1.1 08:03:40 INFO - requests == 1.2.3 08:03:40 INFO - wsgiref == 0.1.2 08:03:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:03:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:03:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:03:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:40 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 0x105c4eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c51768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3924ca530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a2cd30>, '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 0x105953db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a21be8>, '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.Wf35rKklya/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.Arqgkmi4CW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:03:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:03:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:03:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Wf35rKklya/Render', 08:03:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:03:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:03:40 INFO - 'HOME': '/Users/cltbld', 08:03:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:03:40 INFO - 'LOGNAME': 'cltbld', 08:03:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:40 INFO - 'MOZ_NO_REMOTE': '1', 08:03:40 INFO - 'NO_EM_RESTART': '1', 08:03:40 INFO - 'PAGER': '/bin/cat', 08:03:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:03:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:40 INFO - 'PWD': '/builds/slave/test', 08:03:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:03:40 INFO - 'SHELL': '/bin/bash', 08:03:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Arqgkmi4CW/Listeners', 08:03:40 INFO - 'TMPDIR': '/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/', 08:03:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:03:40 INFO - 'USER': 'cltbld', 08:03:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:03:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:03:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:40 INFO - 'XPC_FLAGS': '0x0', 08:03:40 INFO - 'XPC_SERVICE_NAME': '0', 08:03:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:03:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:03:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:03:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:03:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:03:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:03:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:03:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:03:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:03:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:03:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:03:41 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:03:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:03:41 INFO - Cleaning up... 08:03:41 INFO - Return code: 0 08:03:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:03:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:03:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:03:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:41 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 0x105c4eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c51768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3924ca530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a2cd30>, '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 0x105953db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a21be8>, '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.Wf35rKklya/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.Arqgkmi4CW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:03:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:03:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:03:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Wf35rKklya/Render', 08:03:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:03:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:03:41 INFO - 'HOME': '/Users/cltbld', 08:03:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:03:41 INFO - 'LOGNAME': 'cltbld', 08:03:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:41 INFO - 'MOZ_NO_REMOTE': '1', 08:03:41 INFO - 'NO_EM_RESTART': '1', 08:03:41 INFO - 'PAGER': '/bin/cat', 08:03:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:03:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:41 INFO - 'PWD': '/builds/slave/test', 08:03:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:03:41 INFO - 'SHELL': '/bin/bash', 08:03:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Arqgkmi4CW/Listeners', 08:03:41 INFO - 'TMPDIR': '/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/', 08:03:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:03:41 INFO - 'USER': 'cltbld', 08:03:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:03:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:03:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:41 INFO - 'XPC_FLAGS': '0x0', 08:03:41 INFO - 'XPC_SERVICE_NAME': '0', 08:03:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:03:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:03:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:03:41 INFO - Cleaning up... 08:03:41 INFO - Return code: 0 08:03:41 INFO - Running post-action listener: _resource_record_post_action 08:03:41 INFO - Running post-action listener: _start_resource_monitoring 08:03:41 INFO - Starting resource monitoring. 08:03:41 INFO - [mozharness: 2017-02-04 16:03:41.516189Z] Finished create-virtualenv step (success) 08:03:41 INFO - [mozharness: 2017-02-04 16:03:41.517190Z] Running install step. 08:03:41 INFO - Running pre-action listener: _resource_record_pre_action 08:03:41 INFO - Running main action method: install 08:03:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:03:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:03:41 INFO - Reading from file tmpfile_stdout 08:03:41 INFO - Detecting whether we're running mozinstall >=1.0... 08:03:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:03:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:03:41 INFO - Reading from file tmpfile_stdout 08:03:41 INFO - Output received: 08:03:41 INFO - Usage: mozinstall [options] installer 08:03:41 INFO - Options: 08:03:41 INFO - -h, --help show this help message and exit 08:03:41 INFO - -d DEST, --destination=DEST 08:03:41 INFO - Directory to install application into. [default: 08:03:41 INFO - "/builds/slave/test"] 08:03:41 INFO - --app=APP Application being installed. [default: firefox] 08:03:41 INFO - mkdir: /builds/slave/test/build/application 08:03:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:03:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 08:04:03 INFO - Reading from file tmpfile_stdout 08:04:03 INFO - Output received: 08:04:03 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:04:03 INFO - Running post-action listener: _resource_record_post_action 08:04:03 INFO - [mozharness: 2017-02-04 16:04:03.480669Z] Finished install step (success) 08:04:03 INFO - [mozharness: 2017-02-04 16:04:03.480825Z] Running run-tests step. 08:04:03 INFO - Running pre-action listener: _resource_record_pre_action 08:04:03 INFO - Running main action method: run_tests 08:04:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:04:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:04:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:04:03 INFO - 2017-02-04 08:04:03.495 screenresolution[1634:8052] starting screenresolution argv=screenresolution get 08:04:03 INFO - 2017-02-04 08:04:03.498 screenresolution[1634:8052] Display 0: 1600x1200x32@60 08:04:03 INFO - 2017-02-04 08:04:03.503 screenresolution[1635:8055] starting screenresolution argv=screenresolution list 08:04:03 INFO - Available Modes on Display 0 08:04:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:04:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:04:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:04:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:04:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:04:03 INFO - Intel Iris: 08:04:03 INFO - Chipset Model: Intel Iris 08:04:03 INFO - Type: GPU 08:04:03 INFO - Bus: Built-In 08:04:03 INFO - VRAM (Dynamic, Max): 1536 MB 08:04:03 INFO - Vendor: Intel (0x8086) 08:04:03 INFO - Device ID: 0x0a2e 08:04:03 INFO - Revision ID: 0x0009 08:04:03 INFO - Displays: 08:04:03 INFO - Display: 08:04:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:04:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:04:03 INFO - Display Serial Number: 1600x1200 60 08:04:03 INFO - Main Display: Yes 08:04:03 INFO - Mirror: Off 08:04:03 INFO - Online: Yes 08:04:03 INFO - Rotation: Supported 08:04:03 INFO - Return code: 0 08:04:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:04:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:04:03 INFO - Python 2.7.3 08:04:03 INFO - Return code: 0 08:04:03 INFO - grabbing minidump binary from tooltool 08:04:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:04:03 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 0x105a2cd30>, '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 0x105953db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a21be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:04:03 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:04:03 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 08:04:03 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:04:03 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:04:03 INFO - Return code: 0 08:04:03 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:04:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:04:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:04:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:04:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:04:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MX7yl3euQSaS67FMgKiaIA/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0183', '--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 08:04:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MX7yl3euQSaS67FMgKiaIA/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0183 --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 08:04:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Wf35rKklya/Render', 08:04:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:04:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:04:03 INFO - 'HOME': '/Users/cltbld', 08:04:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:04:03 INFO - 'LOGNAME': 'cltbld', 08:04:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:04:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:04:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:03 INFO - 'MOZ_NO_REMOTE': '1', 08:04:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:04:03 INFO - 'NO_EM_RESTART': '1', 08:04:03 INFO - 'PAGER': '/bin/cat', 08:04:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:04:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:03 INFO - 'PWD': '/builds/slave/test', 08:04:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:04:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:04:03 INFO - 'SHELL': '/bin/bash', 08:04:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Arqgkmi4CW/Listeners', 08:04:03 INFO - 'TMPDIR': '/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/', 08:04:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:04:03 INFO - 'USER': 'cltbld', 08:04:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:04:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:04:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:03 INFO - 'XPC_FLAGS': '0x0', 08:04:03 INFO - 'XPC_SERVICE_NAME': '0', 08:04:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:04:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MX7yl3euQSaS67FMgKiaIA/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0183', '--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 08:04:04 INFO - mozversion application_buildid: 20170204072708 08:04:04 INFO - mozversion application_changeset: f8d696a34c172ce8e118d5af0b0e7b7f4bb13105 08:04:04 INFO - mozversion application_display_name: Nightly 08:04:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:04:04 INFO - mozversion application_name: Firefox 08:04:04 INFO - mozversion application_remotingname: firefox 08:04:04 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:04:04 INFO - mozversion application_vendor: Mozilla 08:04:04 INFO - mozversion application_version: 54.0a1 08:04:04 INFO - mozversion platform_buildid: 20170204072708 08:04:04 INFO - mozversion platform_changeset: f8d696a34c172ce8e118d5af0b0e7b7f4bb13105 08:04:04 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:04:04 INFO - mozversion platform_version: 54.0a1 08:04:04 INFO - using testdate: 1486224244 08:04:04 INFO - actual date: 1486224244 08:04:04 INFO - starting webserver on 'localhost:49240' 08:04:04 INFO - SUITE-START | Running 2 tests 08:04:04 INFO - TEST-START | dromaeo_css 08:04:04 INFO - operating with platform_type : mac_ 08:04:04 INFO - Initialising browser for dromaeo_css test... 08:04:04 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/tmp5ICLNS/profile http://localhost:49240/getInfo.html) 08:04:06 INFO - PROCESS | 1645 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 08:04:06 INFO - PROCESS | 1645 | __metrics Screen width/height:1600/1200 08:04:06 INFO - PROCESS | 1645 | colorDepth:24 08:04:06 INFO - PROCESS | 1645 | Browser inner width/height: 1024/689 08:04:06 INFO - PROCESS | 1645 | __metrics 08:04:06 INFO - PROCESS | 1645 | 1486224246801 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 08:04:06 INFO - PROCESS | 1645 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:04:06 INFO - PROCESS | 1645 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:04:07 INFO - TEST-INFO | 1645: exit 0 08:04:07 INFO - Browser initialized. 08:04:07 INFO - Running cycle 1/1 for dromaeo_css test... 08:04:07 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/tmp5ICLNS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:04:19 INFO - PROCESS | 1648 | RSS: Main: 236797952 08:04:19 INFO - PROCESS | 1648 | 08:07:22 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49240/tests/dromaeo/cssquery-ext.html) 08:07:24 INFO - PROCESS | 1648 | RSS: Main: 374235136 08:07:24 INFO - PROCESS | 1648 | 08:09:09 INFO - PROCESS | 1648 | ************************* 08:09:09 INFO - PROCESS | 1648 | A coding exception was thrown and uncaught in a Task. 08:09:09 INFO - PROCESS | 1648 | 08:09:09 ERROR - PROCESS | 1648 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:09:09 INFO - PROCESS | 1648 | Full stack: 08:09:09 INFO - PROCESS | 1648 | ************************* 08:10:27 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-ext.html (next: http://localhost:49240/tests/dromaeo/cssquery-jquery.html) 08:10:27 INFO - PROCESS | 1648 | RSS: Main: 376418304 08:10:27 INFO - PROCESS | 1648 | 08:13:30 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49240/tests/dromaeo/cssquery-mootools.html) 08:13:30 INFO - PROCESS | 1648 | RSS: Main: 349831168 08:13:30 INFO - PROCESS | 1648 | 08:16:32 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49240/tests/dromaeo/cssquery-prototype.html) 08:16:33 INFO - PROCESS | 1648 | RSS: Main: 343379968 08:16:33 INFO - PROCESS | 1648 | 08:19:37 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49240/tests/dromaeo/cssquery-yui.html) 08:19:37 INFO - PROCESS | 1648 | RSS: Main: 336191488 08:19:37 INFO - PROCESS | 1648 | 08:22:41 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-yui.html (next: http://localhost:49240/tests/dromaeo/cssquery-dojo.html) 08:22:41 INFO - PROCESS | 1648 | RSS: Main: 458784768 08:22:41 INFO - PROCESS | 1648 | 08:22:41 INFO - PROCESS | 1648 | __start_tp_report 08:22:41 INFO - PROCESS | 1648 | _x_x_mozilla_page_load 08:22:41 INFO - PROCESS | 1648 | _x_x_mozilla_page_load_details 08:22:41 INFO - PROCESS | 1648 | |i|pagename|runs| 08:22:41 INFO - PROCESS | 1648 | |0;dojo.html;2768.667759868816;3268.967310326896;3275.541424200612;3291.91770205745;3331.783434076785;5336.786528538853;5372.785088596452;5458.263134476844;5524.917126243105;5525.4474552544725;5459.099248623982;5463.672179669213;5469.425710300421;5496.148097044955;5496.983058134238;4910.75446227689;4917.557419832206;4985.127602669537;5089.389273287192;5105.566026887719;5054.267131265964;5066.113430149709;5118.9488105119035;5122.769475373599;5155.5360017598405;4073.877783666495;4109.465769449952;4787.736674482902;4886.9511304886855;5035.093683137034;4204.957950420518;4993.325901003354;5003.474635163292;5016.272640467112;5073.188289873602;4905.043516514281;4956.826511072131;4999.675021123615;5003.149464591028;5007.574356179729;5348.277982472394;5353.197020446925;5446.373667028263;5452.863678408032;5454.481824226692;5870.148828419855;5893.057110862284;5905.025670764318;5917.674527900964;6002.729877155539;6034.577579569432;6060.212172417601;6075.301340345873;6090.056041313604;6104.542159338023;4676.625869930397;5607.80372686954;5619.80330688424;5622.690752008638;5634.521065709419;6004.6097003695495;6007.008843540854;6065.059915713072;6132.122542660378;6194.442500175006;5656.095024796013;5754.424557544212;5758.913616295759;5800.216970708984;5912.231409916683;6029.849253768691;6086.817395478142;6106.126990750407;6116.588446665303;6144.846378840565;5975.40245975399;6026;6030.758769649253;6044.274687037496;6068.302145253264;6015.0977353396465;6023.156758053876;6045.576809623284;6046.304674962347;6051.57638965277;4720.291956206596;4741.95258047422;4791.233402655558;4805.735684537384;4830.830920917751;4285;4297.935530967038;4304.634106100953;4328.5455027222315;4339.652827773833;5529.557635389159;5530.972345138249;5543.667379957215;5544.750486228129;5546.334439867161;5790.305163380337;5892.351841297454;6070.666113363719;6088.939110608837;6109.480694140959;5568.16477528374;5580.665160090326;5582.91625625616;5583.274174357308;5610.298712660918;5270.736463176826;5319;5322;5329;5365.222042803772;6017.428344307284;6068.6358818471035;6132.141360525156;6238.438540531374;6296.874062518724;6033.034714445667;6082;6082.665453400105;6124.448799608057;6125.479334256638;6207.348228435949;6242.250929888442;6266.717997690206;6274;6281;5728.598998070095;5742.684152371659;5889.38161493037;5940.3168635605725;5981;5961.374055724086;5967.194428752063;5991.370906054802;6032.155498230339;6042.486388657014;5828.6502809831545;5833.241678581757;5834.241548598655;5839.532837372915;5849.298084229919;5660.971695141498;5701.287339082614;5704.3154821421695;5779.566532510163;5819.330776960704;5699.743511542073;5715.5713321500225;5731.627444216113;5773.711314434346;5781.075027995501;5837;5837.241158649348;5850.327212370462;5851.853703657443;5862.296524417097;5527.226188333717;5692.345380281321;5698.772049117989;5714.514266287412;5725.2843394575675 08:22:41 INFO - PROCESS | 1648 | |1;ext.html;426.7439536278233;491.91145593793124;493.9654224204303;523.7119584228676;537.0574641504159;29374;39370;40499.59500404995;40567.59432405675;40648.79675601625;40739.79630101853;41140.38289425661;41197.794011029975;41221.58778412215;41466.378004329956;7977.282044615983;8141.267285944264;9278.25773938085;9471.242300615968;9493.81012379752;11006.119510439186;11303.152263580265;11316.547338106466;11368.204225704205;11375.715607109847;11192.216544841864;11278;11279.154063445234;11281.717957051098;11310.264832785842;11237.381943993078;11278.041366483858;11295.661130166109;11322.716932076682;11352.60265890694;11153.832692509619;11232.269902456314;11237.044851187658;11243.718907027307;11268;39254.60745392538;39578.802105989285;39623.405648915286;39627.81116566507;39648.81053568397;3944.5069366329208;3968.980155099206;3969.186316805048;4004.5394779600138;4127.525334586531;29087.127386178236;30482.847585762152;30548.8472557638;30587.388252234832;30930;3117.812931224134;3161.0674850919036;3188.9681103189137;3214.758893083028;3223.9677603224136;439792;613913;620287;623653;626940;50279.497205028216;60608.696956515814;60773;60906;60939.39060609426;62245.37754622487;62531;63195.6840215796;63259.9392048635;63387.04919426212;15057.397704091714;15482;15953.68092638164;15980.76028859568;15998.360065597246;12299.93850030744;12363.949064329632;12378.504859805687;12385.752284954251;12404.25574465535;13354;16199.43301984425;16211.56826476038;16249.943753655974;16280.837191628169;7076.540024898468;7115.359617634334;7136.571805691571;7166.677499512534;7187.604681742449;796.7530065679658;852.1691350932915;857.3184318466834;864.5893200729603;872.8516152254132;28005.438531596763;28941.85529072341;29460.263493412836;30043;30171.396572068435;1013.9847902281472;1024.4109636958779;1059.7668512927144;1061.474570087796;1127.4193790198055;12064;14703.750181234715;15169.848301517064;15197.556232157927;15491.690166196839;613477;613696;613973.9301303554;614891;616624;58149;58316.708416458496;58424.12363814546;58504;58537.12194317089;1358.565259117073;1370.5271681269946;1378.076688618648;1387.500499820064;1397.2315226625315;23893;25442.872785635955;28022.43955120927;29077.273068173465;29122.56316155217;41755;49617.255741163186;49633;49757.253641194686;49997;511603;513729;514459;515855;517502.41248793516;24418.389540260923;24824;38109.618903811715;38248.808755956044;38465.61534384732;40350.798246008584;40992;41075;42155.15689686128;42641.36037959495;34185.31629367349;34847.9545613632;34960.9511714649;35771.64228357683;35836.82081589576;34273.48589771205;34280;35093;35353.646463535035;35599;34073.97778066662;34238.65761342454;34577.13557161091;34755;34757.13107172341;29613.5557966635;30943.690563094082;31008.534871976488;31296.923892071954;31312.373752525276;18951.71572426387;23235.91094993013;23267.341544906136;23512.88243558771;23540.882295588413 08:22:41 INFO - PROCESS | 1648 | |2;jquery.html;341.3906177473211;347.37125802297845;356.45818356098715;395.43847736214565;422.85200179937027;14661.780073298896;14879.553613391588;15491.92254038731;20461.283855065074;21079.894600526975;20653.483662908435;21220.78779212211;21691;21807.345779626598;21855.016524256407;5958.8808223835495;5961.105834124873;6057.54568407369;6211.47202487789;6216.658083805389;5991.400859914017;6082.726277317509;6094.756209751605;6131.3868613138775;6136.785212517563;4010.498687664042;4230.217409779185;4263.488381394237;6107.633541987473;6713.731450741964;6731.730730770763;6744.426723728489;6751.021101940191;6764.458843292525;6771.424428923498;5619.7471113799975;5671.9716401418145;5815.098659707752;5872.559558033165;5887.470127688529;20610;26016;26021.739782602122;26667.733322666914;26727.86636066807;2692.690340610816;2735.513916392186;2736.616873637692;2737.452509498108;2783.318087068661;15413.152276624782;15561.144137072457;15703.450379236787;15848.683026339524;16641.4175503858;1820.681380758362;1868.7944326124116;1873.6065426260502;1876.9812301876943;1904.304928701028;93333;115436.42281788621;115850.42074789573;125716.37141814233;129523.35238323842;9383.24934005278;10512.896145904722;11014.559417623366;11204.943975280072;11388.316700997966;14280.42878284857;14309;14344.641383965485;14354.712905741826;14364.856351436561;8372.497650141011;8538.487690738575;8559.572021398904;8572.742817715478;8659.350548708871;7495.887561686579;7976.242256985577;8393.538355390512;8586.570671466401;8638.481691098554;6987.371136597731;7110.5022648414115;7119.288071192943;7126.928730712731;7138.785836424916;1845.3541260558698;1877.343558864192;1880.2760937039338;1886.415211284506;1887.0941947865101;877.5699907045629;878.2841983783196;887.1793590928365;929.6374413978554;935.5488619816125;19670.70493942592;21818.38070046318;22834.200802971816;23022.76977230206;23100.65349019766;860.6342304520554;900.3922352412096;910.1671970147241;911.9876936600368;924.8381533231658;11059.944700276446;11751.412429378497;11814.763704725858;11820.877016683402;11865.88134118665;627878;712697;741541;756562;758856;129337.35331323283;129980.70019299875;130423.34788326187;131515;132045;982.332014230316;989.0900371658092;1019.1133713669155;1021.1830535571513;1021.305512251676;17970.460886173434;19391.806081939;19666.115024824205;19706.50733731668;19736.30922917691;50866.23700644419;55892.72053639706;56100;56685;57302.426975731374;63856;77458.61270693611;79603.20396796189;80046.79929800941;80173.19826801891;5762.2221000164445;7171.247019062923;7374.373178279691;8006.879896801669;8346.707865224931;13556.254406007763;13691.315434228049;13702;14100;14119.576412707635;11618.121695740874;11855.34795586251;11882.881171188523;11980;12027.639170824888;10815.56737730482;11547.942260288644;11552.480138393625;11761.47073381717;11976.28142311464;11638.476268567765;11638.592649257236;11852.525898963944;11960.043196544082;12008.879911200776;6803.625800581016;8012.359011278967;8201.917980820353;8289.04675962272;8482.57587120629;11438.885611143782;11679.941600291944;11713.481601455727;11855.34795586251;11884.34636095023 08:22:41 INFO - PROCESS | 1648 | |3;mootools.html;1086.3210493441595;1104.00087920432;1107.8836722144179;1109.4840898981975;1175.8530183727034;8139.837203255931;8316.542590157538;8541.829163416744;8559.015713192985;8567.871481927768;8357.540335281557;8588.785280367994;8595.355348348883;8595.441296315736;8613.52625605593;2233.3188377544843;2250.1112060736;2256.537409830989;2257.9322620321336;2261.389424855288;1992.1135094882711;2070.9792902071013;2253.278950735765;2294.6558016297604;2298.689676893615;2019.7778244393105;2189.5839790439763;2259.412552736292;2262.072550254396;2262.694536237603;2247.7415097263697;2254.1772253127656;2266.0369343029147;2266.9206577769864;2271.9091236350528;2211.900464479102;2267.1498188179435;2269.364577918169;2275.24916777463;2277.8861056947085;8570.228679418882;8650.307975362019;8658.480491170487;8666.263367613761;8678.262347700453;4909.8772530686665;5139.665921715076;5153.407358153823;5163.5352818246165;5182.533571978503;3192.9042128736173;3418.9658103418897;3422.3668621305137;3424.9828750856336;3504.526888869995;1149.5976408257127;1196.6888608961647;1215.9574414895437;1221.64483615909;1236.9814452783216;11171.273867198688;11195.72010699739;11272.436378181059;11287.15346349019;11303.491342889589;4134.958650413518;4349;4427.67169849044;4428.4536391574975;4462.3752674625575;8885.511296878605;8887.555622218992;8895.110488951053;8900.688475903313;8901.332400070021;5093.898122037538;5094.962015193878;5104.081265372194;5106.183010718267;5107.336046313955;4466.865994020184;4519;4567.703099298535;4571.839985600488;4651.325557794101;3532.152283451953;3578.534790477221;3581.5164952731047;3630.8184590770356;3634.6910512606723;1055.514463346869;1143.7369405036889;1146.7247860513417;1154.4343271796927;1155.8959693627614;771.5842767389253;878.3061381508537;920.1672486399818;932.9923682422967;951.5429014601257;5410.91883621746;5497.697626630574;5630.40880707528;5634.690092044977;5782.797602083907;1010.8989101089979;1012.8328825743818;1036.740814796301;1041.7812259425455;1070.5182667799522;3615.493830863681;3687.963120368762;3798.8290526925803;3807.124361396894;3838.1960478575024;9743.512824358895;10164.237682173867;10173.54219060144;10183.490825458697;10212.693619191436;9751.317407781387;9782.021797820162;10013.64952226683;10117.595296188218;10134.290599657954;7715.768526944088;7719;7807.102183248886;7909.169537198626;7916.089649690244;5401.4868587484125;5434.83695489136;5484.561235101262;5538.113901775858;5568.916466252928;6970.51206415546;9399.96600373972;9406.341556091007;9416.717498475056;9442.38624489406;7459.440541959266;9388.389754665925;9394.295427843075;9508.619655213713;9563.665271715456;6623.701933412912;7372.041634587469;7386.482946193715;7394;7396.149442814145;7972;8044.3162331200165;8046.839063218586;8051.677932882619;8054.879176812469;7119.857602848017;7158.713651453883;7312.341889229995;7349;7375.37309328713;7049;7118.786436406916;7129.215786263403;7168.103987001625;7194.532355396883;5459.317585301837;6365.1088847562305;6403.007533832263;6456.257530384066;6543.051257567531;5064.696118232918;5069.543741063175;5115.360579927509;5121.871953201051;5221.869453263699;4964.1900388168815;4973.875653108701;5091.032703786269;5267.236250743697;5283.867903302448 08:22:41 INFO - PROCESS | 1648 | |4;prototype.html;287.657687352051;346.82658670664665;354.02466205603565;357.4316836230393;358.96769290763825;4728.030753695497;4895.804167833287;4913.7788799504015;5081.8221362252325;5174.335217363061;4746.477887432388;5022.472640372763;5042.647014708972;5042.899142017158;5081.745912704359;3094.427530906778;3621.026540535401;3826.827792749326;3881.592432794558;3893.6301051400073;3679.7737368891835;3843.2121415109837;3850.84596616135;3879.456876037343;3926.862559810407;3859.282619234442;3865.555461121965;3876.282887665791;3877.7091718121114;3879.5538513070933;2917.7957542972;3110.9688903111132;3418.658134186574;3848.3842585186235;3881.2454742939813;3312.2216279174377;3313.867445302185;3314.552535407737;3320.25294308781;3463.4631632097066;4266.87199384019;4557.339185818071;4617.5151609080895;4950;4989.675671081368;4220.53574106848;4345.174416860787;4362.411074504965;4366.345048242789;4422.889427764299;4380.474343078851;5034.4713805050305;5217.452167522393;5305.840824775263;5372.919406208871;3189.6650851660474;3675.246574452231;3676.981615091934;3695.981520092409;3697.574778900434;4720.315554244649;4841.128596852565;5372;5500.074973759152;5687.601867869251;3015.728584427412;3691.298653255873;3701.3892707702926;3720;3789.1474418256225;3073.938521229563;3748.8125593720206;3768.2840260350445;3778.527684039495;3782.5650050244026;3517.56030496188;3527.4885141654318;3936.0946982194255;4333.349997500401;4356.390105385249;4591;4793;5135.4094279157625;5372.650777699515;5372.677639341652;1169.3626973299572;1181.5805389086922;1220.4812954494305;1222.6882145052955;1224.13086708438;682.7200847652439;763.023330137425;775.3687909154295;819.1399031017407;831.2809419851785;4412.646988240997;4733.668643194943;4747.172338649576;4765.5949244314625;4771.33201351811;4539.6368290536675;4693.413323334583;5252.606054545848;5277.02375060615;5287.35632183908;3966.874450571431;4100.610442008005;4701.576858082721;4738;4794.424669039668;2230.910763569439;2338.7427382987858;2480.7395223501635;2515.584928486779;2769.529180039398;4463.348561032439;4770.752172610101;5203.375594928632;5286.603504737083;5444.863878402993;4472.39622650938;4967.837901031265;4986;5352.732363381815;5452.672839629635;4694.929576056362;4834.564889159992;5093.8726531837;5197.792088316425;5431.755570999236;4972.453030166606;5084.669496482717;5181.17101263811;5191.402988656353;5203.921941170961;4074.714769966074;4256.765537993947;4611.93082103762;4997.675151115166;5161.922571161511;5105.18317069282;5676.829695109153;5684.545236380997;5717.656940583578;5739.2252045973255;3456.4469684850305;3657.2868290684128;3825.2923209206388;3883.6893048555485;4014.4580481634607;5448.891022179613;5482.725863706878;5544.584156188383;5550.833474995757;5570.604640004837;4518.88702782433;5002.349694539832;5370.409254981871;5414.8646283841645;5424.647397919122;5330.866728331823;5336.359636843604;5384.3347542966485;5394.892102158014;5401.972990135024;4182.853600123981;4440.111977604427;5308.362996440452;5308.4160742317545;5319.281896943863;4072.3687828386646;5058.570021548209;5069.569086627678;5327.653702509325;5358.651687640291;4443.644508439382;4456.331550267486;4949.851504454872;5283.16590319853;5292.867678308073 08:22:41 INFO - PROCESS | 1648 | |5;yui.html;704.6159842885627;728.0171768113045;743.5687301365208;768.1742127213247;818.3862103422431;13804.240766757825;14334.641633959156;14579.48971785989;14584.781228281585;14592.41630334788;13361.933190334035;13549.390277437515;13632.182069075863;13663.795043074362;13669.863301366984;876.7325965580495;880.5729221327651;884.8363052835214;900.8333458310217;913.7213149989251;877.6533269358599;890.6882591093098;890.9153630405101;891.7012800711769;891.8216356728648;925.995295104812;927.9536023198847;930.1024511346549;931.3666706639483;932.6129656192705;923.9907600923972;926.7914719188196;928.0023974227698;928.2017464980112;929.4562680831688;691.6438034412282;691.7267679266712;692.0899017791588;692.1210063219733;695.6347917343385;14491.927540362336;14736.926315368355;14827.481038163613;14872.182029988346;15170.620734481616;11701.707457313636;13474.797878031837;13718.811249145909;14011.509597164153;14111.153330800082;11404.942975285154;11729.589464368792;11859.58491452795;12155.939220303842;12414.81377779334;3659.9085022874374;3678.742488025839;3689.631036896316;3692.6216920470506;3727.34771415004;100388;102969;105296;105747.47126264396;106507.46746266374;10762.515686794113;10764.623238186627;10868.67393978182;10999.34003959765;11206.215564910379;21636;21764.891175544337;21966.670499942513;22005;22084;7491.475596708178;7510.511816731895;7513.737019204411;7589.544627322378;7640.465167438226;3719.6466335698065;4014.698897582693;4118.608732170439;4124.7731374774075;4275.87172384829;3374.392609330344;3375.1562109472634;3459.1697992481622;3485.076454739496;3501.124718820295;633.3856159525253;634.2167423232304;645.7481582182952;651.5667081390822;654.0810161722787;626.764963138823;642.8425035866243;662.8541720821412;672.8149758816364;677.072410797211;9270.30472714549;9697.272704547046;9838.212942964547;9838.311318207656;9912.702618921443;638.409471239102;662.1458318768734;669.2270427656065;683.0676127086491;687.3470203306879;4841.830535931225;5372.382176049804;5481.616286859881;5506.229127922094;5565.165225216169;91886;94869.5256523713;97859.53210701846;98856;99339.00660993297;88791;88851.11148888429;90452.09547904569;90472.54763726139;92095.1580968377;78472.2152778465;78531;79221.20778792369;79858;80511.19488805154;10819.729506762395;11063.778724425627;11154.832677510007;11180.161487888603;11373.431328433711;47011.76494117644;47293.527064728914;47896;48368.75815620899;49318;59945;66229.66885165543;66398.6680066616;69327.96008059983;71615.28384716086;11207.439628018403;13143.342832858127;13328.733425331246;13638.79541806854;13705.862941370458;14749.631259218606;14968.326425311105;15035.473758418402;15044.473443429428;15106;13920.164790112625;14003.859961400256;14187.574372768833;14610;14634.853651463349;13941.93029034889;14052;14054.859451405355;14189.29053547298;14306.213158276394;13310.201387916755;13405.128666636638;14244;14265.286735663383;14267.785983210053;11141.888581114084;11215.934486223796;11217.214794964275;11589.130815188726;11787.705307367385;10841.975812675244;11129.387883666475;11191.38447385369;11210.43947802623;11322.60370887015 08:22:41 INFO - PROCESS | 1648 | __end_tp_report 08:22:41 INFO - PROCESS | 1648 | __start_cc_report 08:22:41 INFO - PROCESS | 1648 | _x_x_mozilla_cycle_collect,1481 08:22:41 INFO - PROCESS | 1648 | __end_cc_report 08:22:41 INFO - PROCESS | 1648 | __startTimestamp1486225361344__endTimestamp 08:22:41 INFO - PROCESS | 1648 | 08:22:41 INFO - PROCESS | 1648 | ------- Summary: start ------- 08:22:41 INFO - PROCESS | 1648 | Number of tests: 6 08:22:41 INFO - PROCESS | 1648 | 08:22:41 INFO - PROCESS | 1648 | [#0] dojo.html Cycles:165 Average:5520.67 Median:5704.32 stddev:653.06 (11.4%) stddev-sans-first:618.35 08:22:41 INFO - PROCESS | 1648 | Values: 2768.7 3269.0 3275.5 3291.9 3331.8 5336.8 5372.8 5458.3 5524.9 5525.4 5459.1 5463.7 5469.4 5496.1 5497.0 4910.8 4917.6 4985.1 5089.4 5105.6 5054.3 5066.1 5118.9 5122.8 5155.5 4073.9 4109.5 4787.7 4887.0 5035.1 4205.0 4993.3 5003.5 5016.3 5073.2 4905.0 4956.8 4999.7 5003.1 5007.6 5348.3 5353.2 5446.4 5452.9 5454.5 5870.1 5893.1 5905.0 5917.7 6002.7 6034.6 6060.2 6075.3 6090.1 6104.5 4676.6 5607.8 5619.8 5622.7 5634.5 6004.6 6007.0 6065.1 6132.1 6194.4 5656.1 5754.4 5758.9 5800.2 5912.2 6029.8 6086.8 6106.1 6116.6 6144.8 5975.4 6026.0 6030.8 6044.3 6068.3 6015.1 6023.2 6045.6 6046.3 6051.6 4720.3 4742.0 4791.2 4805.7 4830.8 4285.0 4297.9 4304.6 4328.5 4339.7 5529.6 5531.0 5543.7 5544.8 5546.3 5790.3 5892.4 6070.7 6088.9 6109.5 5568.2 5580.7 5582.9 5583.3 5610.3 5270.7 5319.0 5322.0 5329.0 5365.2 6017.4 6068.6 6132.1 6238.4 6296.9 6033.0 6082.0 6082.7 6124.4 6125.5 6207.3 6242.3 6266.7 6274.0 6281.0 5728.6 5742.7 5889.4 5940.3 5981.0 5961.4 5967.2 5991.4 6032.2 6042.5 5828.7 5833.2 5834.2 5839.5 5849.3 5661.0 5701.3 5704.3 5779.6 5819.3 5699.7 5715.6 5731.6 5773.7 5781.1 5837.0 5837.2 5850.3 5851.9 5862.3 5527.2 5692.3 5698.8 5714.5 5725.3 08:22:41 INFO - PROCESS | 1648 | 08:22:41 INFO - PROCESS | 1648 | [#1] ext.html Cycles:180 Average:69727.65 Median:34802.54 stddev:153611.93 (441.4%) stddev-sans-first:153954.73 08:22:41 INFO - PROCESS | 1648 | Values: 426.7 491.9 494.0 523.7 537.1 29374.0 39370.0 40499.6 40567.6 40648.8 40739.8 41140.4 41197.8 41221.6 41466.4 7977.3 8141.3 9278.3 9471.2 9493.8 11006.1 11303.2 11316.5 11368.2 11375.7 11192.2 11278.0 11279.2 11281.7 11310.3 11237.4 11278.0 11295.7 11322.7 11352.6 11153.8 11232.3 11237.0 11243.7 11268.0 39254.6 39578.8 39623.4 39627.8 39648.8 3944.5 3969.0 3969.2 4004.5 4127.5 29087.1 30482.8 30548.8 30587.4 30930.0 3117.8 3161.1 3189.0 3214.8 3224.0 439792.0 613913.0 620287.0 623653.0 626940.0 50279.5 60608.7 60773.0 60906.0 60939.4 62245.4 62531.0 63195.7 63259.9 63387.0 15057.4 15482.0 15953.7 15980.8 15998.4 12299.9 12363.9 12378.5 12385.8 12404.3 13354.0 16199.4 16211.6 16249.9 16280.8 7076.5 7115.4 7136.6 7166.7 7187.6 796.8 852.2 857.3 864.6 872.9 28005.4 28941.9 29460.3 30043.0 30171.4 1014.0 1024.4 1059.8 1061.5 1127.4 12064.0 14703.8 15169.8 15197.6 15491.7 613477.0 613696.0 613973.9 614891.0 616624.0 58149.0 58316.7 58424.1 58504.0 58537.1 1358.6 1370.5 1378.1 1387.5 1397.2 23893.0 25442.9 28022.4 29077.3 29122.6 41755.0 49617.3 49633.0 49757.3 49997.0 511603.0 513729.0 514459.0 515855.0 517502.4 24418.4 24824.0 38109.6 38248.8 38465.6 40350.8 40992.0 41075.0 42155.2 42641.4 34185.3 34848.0 34961.0 35771.6 35836.8 34273.5 34280.0 35093.0 35353.6 35599.0 34074.0 34238.7 34577.1 34755.0 34757.1 29613.6 30943.7 31008.5 31296.9 31312.4 18951.7 23235.9 23267.3 23512.9 23540.9 08:22:41 INFO - PROCESS | 1648 | 08:22:41 INFO - PROCESS | 1648 | [#2] jquery.html Cycles:180 Average:38748.79 Median:14710.28 stddev:119336.66 (811.2%) stddev-sans-first:119636.58 08:22:41 INFO - PROCESS | 1648 | Values: 341.4 347.4 356.5 395.4 422.9 14661.8 14879.6 15491.9 20461.3 21079.9 20653.5 21220.8 21691.0 21807.3 21855.0 5958.9 5961.1 6057.5 6211.5 6216.7 5991.4 6082.7 6094.8 6131.4 6136.8 4010.5 4230.2 4263.5 6107.6 6713.7 6731.7 6744.4 6751.0 6764.5 6771.4 5619.7 5672.0 5815.1 5872.6 5887.5 20610.0 26016.0 26021.7 26667.7 26727.9 2692.7 2735.5 2736.6 2737.5 2783.3 15413.2 15561.1 15703.5 15848.7 16641.4 1820.7 1868.8 1873.6 1877.0 1904.3 93333.0 115436.4 115850.4 125716.4 129523.4 9383.2 10512.9 11014.6 11204.9 11388.3 14280.4 14309.0 14344.6 14354.7 14364.9 8372.5 8538.5 8559.6 8572.7 8659.4 7495.9 7976.2 8393.5 8586.6 8638.5 6987.4 7110.5 7119.3 7126.9 7138.8 1845.4 1877.3 1880.3 1886.4 1887.1 877.6 878.3 887.2 929.6 935.5 19670.7 21818.4 22834.2 23022.8 23100.7 860.6 900.4 910.2 912.0 924.8 11059.9 11751.4 11814.8 11820.9 11865.9 627878.0 712697.0 741541.0 756562.0 758856.0 129337.4 129980.7 130423.3 131515.0 132045.0 982.3 989.1 1019.1 1021.2 1021.3 17970.5 19391.8 19666.1 19706.5 19736.3 50866.2 55892.7 56100.0 56685.0 57302.4 63856.0 77458.6 79603.2 80046.8 80173.2 5762.2 7171.2 7374.4 8006.9 8346.7 13556.3 13691.3 13702.0 14100.0 14119.6 11618.1 11855.3 11882.9 11980.0 12027.6 10815.6 11547.9 11552.5 11761.5 11976.3 11638.5 11638.6 11852.5 11960.0 12008.9 6803.6 8012.4 8201.9 8289.0 8482.6 11438.9 11679.9 11713.5 11855.3 11884.3 08:22:41 INFO - PROCESS | 1648 | 08:22:41 INFO - PROCESS | 1648 | [#3] mootools.html Cycles:180 Average:5423.10 Median:5105.13 stddev:3017.92 (59.1%) stddev-sans-first:3008.78 08:22:41 INFO - PROCESS | 1648 | Values: 1086.3 1104.0 1107.9 1109.5 1175.9 8139.8 8316.5 8541.8 8559.0 8567.9 8357.5 8588.8 8595.4 8595.4 8613.5 2233.3 2250.1 2256.5 2257.9 2261.4 1992.1 2071.0 2253.3 2294.7 2298.7 2019.8 2189.6 2259.4 2262.1 2262.7 2247.7 2254.2 2266.0 2266.9 2271.9 2211.9 2267.1 2269.4 2275.2 2277.9 8570.2 8650.3 8658.5 8666.3 8678.3 4909.9 5139.7 5153.4 5163.5 5182.5 3192.9 3419.0 3422.4 3425.0 3504.5 1149.6 1196.7 1216.0 1221.6 1237.0 11171.3 11195.7 11272.4 11287.2 11303.5 4135.0 4349.0 4427.7 4428.5 4462.4 8885.5 8887.6 8895.1 8900.7 8901.3 5093.9 5095.0 5104.1 5106.2 5107.3 4466.9 4519.0 4567.7 4571.8 4651.3 3532.2 3578.5 3581.5 3630.8 3634.7 1055.5 1143.7 1146.7 1154.4 1155.9 771.6 878.3 920.2 933.0 951.5 5410.9 5497.7 5630.4 5634.7 5782.8 1010.9 1012.8 1036.7 1041.8 1070.5 3615.5 3688.0 3798.8 3807.1 3838.2 9743.5 10164.2 10173.5 10183.5 10212.7 9751.3 9782.0 10013.6 10117.6 10134.3 7715.8 7719.0 7807.1 7909.2 7916.1 5401.5 5434.8 5484.6 5538.1 5568.9 6970.5 9400.0 9406.3 9416.7 9442.4 7459.4 9388.4 9394.3 9508.6 9563.7 6623.7 7372.0 7386.5 7394.0 7396.1 7972.0 8044.3 8046.8 8051.7 8054.9 7119.9 7158.7 7312.3 7349.0 7375.4 7049.0 7118.8 7129.2 7168.1 7194.5 5459.3 6365.1 6403.0 6456.3 6543.1 5064.7 5069.5 5115.4 5121.9 5221.9 4964.2 4973.9 5091.0 5267.2 5283.9 08:22:41 INFO - PROCESS | 1648 | 08:22:41 INFO - PROCESS | 1648 | [#4] prototype.html Cycles:180 Average:4199.28 Median:4694.17 stddev:1295.37 (27.6%) stddev-sans-first:1265.29 08:22:41 INFO - PROCESS | 1648 | Values: 287.7 346.8 354.0 357.4 359.0 4728.0 4895.8 4913.8 5081.8 5174.3 4746.5 5022.5 5042.6 5042.9 5081.7 3094.4 3621.0 3826.8 3881.6 3893.6 3679.8 3843.2 3850.8 3879.5 3926.9 3859.3 3865.6 3876.3 3877.7 3879.6 2917.8 3111.0 3418.7 3848.4 3881.2 3312.2 3313.9 3314.6 3320.3 3463.5 4266.9 4557.3 4617.5 4950.0 4989.7 4220.5 4345.2 4362.4 4366.3 4422.9 4380.5 5034.5 5217.5 5305.8 5372.9 3189.7 3675.2 3677.0 3696.0 3697.6 4720.3 4841.1 5372.0 5500.1 5687.6 3015.7 3691.3 3701.4 3720.0 3789.1 3073.9 3748.8 3768.3 3778.5 3782.6 3517.6 3527.5 3936.1 4333.3 4356.4 4591.0 4793.0 5135.4 5372.7 5372.7 1169.4 1181.6 1220.5 1222.7 1224.1 682.7 763.0 775.4 819.1 831.3 4412.6 4733.7 4747.2 4765.6 4771.3 4539.6 4693.4 5252.6 5277.0 5287.4 3966.9 4100.6 4701.6 4738.0 4794.4 2230.9 2338.7 2480.7 2515.6 2769.5 4463.3 4770.8 5203.4 5286.6 5444.9 4472.4 4967.8 4986.0 5352.7 5452.7 4694.9 4834.6 5093.9 5197.8 5431.8 4972.5 5084.7 5181.2 5191.4 5203.9 4074.7 4256.8 4611.9 4997.7 5161.9 5105.2 5676.8 5684.5 5717.7 5739.2 3456.4 3657.3 3825.3 3883.7 4014.5 5448.9 5482.7 5544.6 5550.8 5570.6 4518.9 5002.3 5370.4 5414.9 5424.6 5330.9 5336.4 5384.3 5394.9 5402.0 4182.9 4440.1 5308.4 5308.4 5319.3 4072.4 5058.6 5069.6 5327.7 5358.7 4443.6 4456.3 4949.9 5283.2 5292.9 08:22:41 INFO - PROCESS | 1648 | 08:22:41 INFO - PROCESS | 1648 | [#5] yui.html Cycles:180 Average:20292.61 Median:3871.02 stddev:28792.64 (743.8%) stddev-sans-first:28835.84 08:22:41 INFO - PROCESS | 1648 | Values: 704.6 728.0 743.6 768.2 818.4 13804.2 14334.6 14579.5 14584.8 14592.4 13361.9 13549.4 13632.2 13663.8 13669.9 876.7 880.6 884.8 900.8 913.7 877.7 890.7 890.9 891.7 891.8 926.0 928.0 930.1 931.4 932.6 924.0 926.8 928.0 928.2 929.5 691.6 691.7 692.1 692.1 695.6 14491.9 14736.9 14827.5 14872.2 15170.6 11701.7 13474.8 13718.8 14011.5 14111.2 11404.9 11729.6 11859.6 12155.9 12414.8 3659.9 3678.7 3689.6 3692.6 3727.3 100388.0 102969.0 105296.0 105747.5 106507.5 10762.5 10764.6 10868.7 10999.3 11206.2 21636.0 21764.9 21966.7 22005.0 22084.0 7491.5 7510.5 7513.7 7589.5 7640.5 3719.6 4014.7 4118.6 4124.8 4275.9 3374.4 3375.2 3459.2 3485.1 3501.1 633.4 634.2 645.7 651.6 654.1 626.8 642.8 662.9 672.8 677.1 9270.3 9697.3 9838.2 9838.3 9912.7 638.4 662.1 669.2 683.1 687.3 4841.8 5372.4 5481.6 5506.2 5565.2 91886.0 94869.5 97859.5 98856.0 99339.0 88791.0 88851.1 90452.1 90472.5 92095.2 78472.2 78531.0 79221.2 79858.0 80511.2 10819.7 11063.8 11154.8 11180.2 11373.4 47011.8 47293.5 47896.0 48368.8 49318.0 59945.0 66229.7 66398.7 69328.0 71615.3 11207.4 13143.3 13328.7 13638.8 13705.9 14749.6 14968.3 15035.5 15044.5 15106.0 13920.2 14003.9 14187.6 14610.0 14634.9 13941.9 14052.0 14054.9 14189.3 14306.2 13310.2 13405.1 14244.0 14265.3 14267.8 11141.9 11215.9 11217.2 11589.1 11787.7 10842.0 11129.4 11191.4 11210.4 11322.6 08:22:41 INFO - PROCESS | 1648 | -------- Summary: end -------- 08:22:41 INFO - PROCESS | 1648 | 08:22:41 INFO - TEST-INFO | 1648: exit 0 08:22:41 INFO - TEST-OK | dromaeo_css | took 1117866ms 08:22:41 INFO - TEST-START | kraken 08:22:41 INFO - operating with platform_type : mac_ 08:22:41 INFO - Initialising browser for kraken test... 08:22:41 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/tmpgf7OcI/profile http://localhost:49240/getInfo.html) 08:22:44 INFO - PROCESS | 1654 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 08:22:44 INFO - PROCESS | 1654 | __metrics Screen width/height:1600/1200 08:22:44 INFO - PROCESS | 1654 | colorDepth:24 08:22:44 INFO - PROCESS | 1654 | Browser inner width/height: 1024/689 08:22:44 INFO - PROCESS | 1654 | __metrics 08:22:44 INFO - PROCESS | 1654 | 1486225364383 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 08:22:44 INFO - PROCESS | 1654 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:22:44 INFO - PROCESS | 1654 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:22:45 INFO - TEST-INFO | 1654: exit 0 08:22:45 INFO - Browser initialized. 08:22:45 INFO - Running cycle 1/1 for kraken test... 08:22:45 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/T/tmpgf7OcI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:22:57 INFO - PROCESS | 1655 | RSS: Main: 236163072 08:22:57 INFO - PROCESS | 1655 | 08:23:00 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection) 08:23:00 INFO - PROCESS | 1655 | RSS: Main: 288927744 08:23:00 INFO - PROCESS | 1655 | 08:23:03 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-dft) 08:23:04 INFO - PROCESS | 1655 | RSS: Main: 292339712 08:23:04 INFO - PROCESS | 1655 | 08:23:07 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-fft) 08:23:08 INFO - PROCESS | 1655 | RSS: Main: 382099456 08:23:08 INFO - PROCESS | 1655 | 08:23:10 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator) 08:23:10 INFO - PROCESS | 1655 | RSS: Main: 282800128 08:23:10 INFO - PROCESS | 1655 | 08:23:12 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:23:13 INFO - PROCESS | 1655 | RSS: Main: 285970432 08:23:13 INFO - PROCESS | 1655 | 08:23:16 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom) 08:23:16 INFO - PROCESS | 1655 | RSS: Main: 329998336 08:23:16 INFO - PROCESS | 1655 | 08:23:19 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate) 08:23:20 INFO - PROCESS | 1655 | RSS: Main: 330952704 08:23:20 INFO - PROCESS | 1655 | 08:23:23 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial) 08:23:23 INFO - PROCESS | 1655 | RSS: Main: 329703424 08:23:23 INFO - PROCESS | 1655 | 08:23:25 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:23:26 INFO - PROCESS | 1655 | RSS: Main: 305360896 08:23:26 INFO - PROCESS | 1655 | 08:23:28 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:23:28 INFO - PROCESS | 1655 | RSS: Main: 309538816 08:23:28 INFO - PROCESS | 1655 | 08:23:30 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:23:31 INFO - PROCESS | 1655 | RSS: Main: 311787520 08:23:31 INFO - PROCESS | 1655 | 08:23:34 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:23:35 INFO - PROCESS | 1655 | RSS: Main: 328388608 08:23:35 INFO - PROCESS | 1655 | 08:23:38 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:23:38 INFO - PROCESS | 1655 | RSS: Main: 322363392 08:23:38 INFO - PROCESS | 1655 | 08:23:40 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49240/tests/kraken/driver.html?testName=ai-astar) 08:23:40 INFO - PROCESS | 1655 | RSS: Main: 367378432 08:23:40 INFO - PROCESS | 1655 | 08:23:40 INFO - PROCESS | 1655 | __start_tp_report 08:23:40 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 08:23:40 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 08:23:40 INFO - PROCESS | 1655 | |i|pagename|runs| 08:23:40 INFO - PROCESS | 1655 | |0;ai-astar;114;112;114;112;112;113;113;113;114;116 08:23:40 INFO - PROCESS | 1655 | |1;audio-beat-detection;139;108;107;143;119;140;119;116;160;141 08:23:40 INFO - PROCESS | 1655 | |2;audio-dft;183;181;182;186;182;181;178;182;183;185 08:23:40 INFO - PROCESS | 1655 | |3;audio-fft;79;69;58;85;60;59;58;58;74;56 08:23:40 INFO - PROCESS | 1655 | |4;audio-oscillator;84;71;86;71;68;69;86;68;70;83 08:23:40 INFO - PROCESS | 1655 | |5;imaging-gaussian-blur;88;84;93;131;87;84;89;85;89;84 08:23:40 INFO - PROCESS | 1655 | |6;imaging-darkroom;97;98;97;97;96;97;97;97;97;97 08:23:40 INFO - PROCESS | 1655 | |7;imaging-desaturate;86;86;87;84;86;85;85;86;87;84 08:23:40 INFO - PROCESS | 1655 | |8;json-parse-financial;58;55;56;56;57;57;57;57;57;57 08:23:40 INFO - PROCESS | 1655 | |9;json-stringify-tinderbox;65;75;68;74;70;69;67;70;70;68 08:23:40 INFO - PROCESS | 1655 | |10;stanford-crypto-aes;87;90;84;85;86;86;85;86;87;86 08:23:40 INFO - PROCESS | 1655 | |11;stanford-crypto-ccm;139;151;151;147;126;138;137;134;178;166 08:23:40 INFO - PROCESS | 1655 | |12;stanford-crypto-pbkdf2;172;171;172;171;174;197;237;194;172;172 08:23:40 INFO - PROCESS | 1655 | |13;stanford-crypto-sha256-iterative;67;66;68;64;66;65;67;59;59;78 08:23:40 INFO - PROCESS | 1655 | __end_tp_report 08:23:40 INFO - PROCESS | 1655 | __start_cc_report 08:23:40 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,2111 08:23:40 INFO - PROCESS | 1655 | __end_cc_report 08:23:40 INFO - PROCESS | 1655 | __startTimestamp1486225420930__endTimestamp 08:23:40 INFO - PROCESS | 1655 | 08:23:40 INFO - PROCESS | 1655 | ------- Summary: start ------- 08:23:40 INFO - PROCESS | 1655 | Number of tests: 14 08:23:40 INFO - PROCESS | 1655 | 08:23:40 INFO - PROCESS | 1655 | [#0] ai-astar Cycles:10 Average:113.30 Median:113.50 stddev:1.25 (1.1%) stddev-sans-first:1.30 08:23:40 INFO - PROCESS | 1655 | Values: 114.0 112.0 114.0 112.0 112.0 113.0 113.0 113.0 114.0 116.0 08:23:40 INFO - PROCESS | 1655 | 08:23:40 INFO - PROCESS | 1655 | [#1] audio-beat-detection Cycles:10 Average:129.20 Median:139.50 stddev:17.69 (12.7%) stddev-sans-first:18.40 08:23:40 INFO - PROCESS | 1655 | Values: 139.0 108.0 107.0 143.0 119.0 140.0 119.0 116.0 160.0 141.0 08:23:40 INFO - PROCESS | 1655 | 08:23:40 INFO - PROCESS | 1655 | [#2] audio-dft Cycles:10 Average:182.30 Median:182.50 stddev:2.21 (1.2%) stddev-sans-first:2.33 08:23:40 INFO - PROCESS | 1655 | Values: 183.0 181.0 182.0 186.0 182.0 181.0 178.0 182.0 183.0 185.0 08:23:40 INFO - PROCESS | 1655 | 08:23:40 INFO - PROCESS | 1655 | [#3] audio-fft Cycles:10 Average:65.60 Median:64.50 stddev:10.43 (16.2%) stddev-sans-first:9.87 08:23:40 INFO - PROCESS | 1655 | Values: 79.0 69.0 58.0 85.0 60.0 59.0 58.0 58.0 74.0 56.0 08:23:40 INFO - PROCESS | 1655 | 08:23:40 INFO - PROCESS | 1655 | [#4] audio-oscillator Cycles:10 Average:75.60 Median:77.00 stddev:7.99 (10.4%) stddev-sans-first:7.87 08:23:40 INFO - PROCESS | 1655 | Values: 84.0 71.0 86.0 71.0 68.0 69.0 86.0 68.0 70.0 83.0 08:23:40 INFO - PROCESS | 1655 | 08:23:40 INFO - PROCESS | 1655 | [#5] imaging-gaussian-blur Cycles:10 Average:91.40 Median:87.50 stddev:14.21 (16.2%) stddev-sans-first:15.02 08:23:40 INFO - PROCESS | 1655 | Values: 88.0 84.0 93.0 131.0 87.0 84.0 89.0 85.0 89.0 84.0 08:23:40 INFO - PROCESS | 1655 | 08:23:40 INFO - PROCESS | 1655 | [#6] imaging-darkroom Cycles:10 Average:97.00 Median:97.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 08:23:40 INFO - PROCESS | 1655 | Values: 97.0 98.0 97.0 97.0 96.0 97.0 97.0 97.0 97.0 97.0 08:23:40 INFO - PROCESS | 1655 | 08:23:40 INFO - PROCESS | 1655 | [#7] imaging-desaturate Cycles:10 Average:85.60 Median:86.00 stddev:1.07 (1.2%) stddev-sans-first:1.13 08:23:40 INFO - PROCESS | 1655 | Values: 86.0 86.0 87.0 84.0 86.0 85.0 85.0 86.0 87.0 84.0 08:23:40 INFO - PROCESS | 1655 | 08:23:40 INFO - PROCESS | 1655 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:57.00 stddev:0.82 (1.4%) stddev-sans-first:0.73 08:23:40 INFO - PROCESS | 1655 | Values: 58.0 55.0 56.0 56.0 57.0 57.0 57.0 57.0 57.0 57.0 08:23:40 INFO - PROCESS | 1655 | 08:23:40 INFO - PROCESS | 1655 | [#9] json-stringify-tinderbox Cycles:10 Average:69.60 Median:70.00 stddev:3.03 (4.3%) stddev-sans-first:2.71 08:23:40 INFO - PROCESS | 1655 | Values: 65.0 75.0 68.0 74.0 70.0 69.0 67.0 70.0 70.0 68.0 08:23:40 INFO - PROCESS | 1655 | 08:23:40 INFO - PROCESS | 1655 | [#10] stanford-crypto-aes Cycles:10 Average:86.20 Median:86.00 stddev:1.62 (1.9%) stddev-sans-first:1.69 08:23:40 INFO - PROCESS | 1655 | Values: 87.0 90.0 84.0 85.0 86.0 86.0 85.0 86.0 87.0 86.0 08:23:40 INFO - PROCESS | 1655 | 08:23:40 INFO - PROCESS | 1655 | [#11] stanford-crypto-ccm Cycles:10 Average:146.70 Median:149.00 stddev:15.66 (10.5%) stddev-sans-first:16.36 08:23:40 INFO - PROCESS | 1655 | Values: 139.0 151.0 151.0 147.0 126.0 138.0 137.0 134.0 178.0 166.0 08:23:40 INFO - PROCESS | 1655 | 08:23:40 INFO - PROCESS | 1655 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.20 Median:173.00 stddev:21.31 (12.3%) stddev-sans-first:22.21 08:23:40 INFO - PROCESS | 1655 | Values: 172.0 171.0 172.0 171.0 174.0 197.0 237.0 194.0 172.0 172.0 08:23:40 INFO - PROCESS | 1655 | 08:23:40 INFO - PROCESS | 1655 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.50 stddev:5.30 (8.0%) stddev-sans-first:5.61 08:23:40 INFO - PROCESS | 1655 | Values: 67.0 66.0 68.0 64.0 66.0 65.0 67.0 59.0 59.0 78.0 08:23:40 INFO - PROCESS | 1655 | -------- Summary: end -------- 08:23:40 INFO - PROCESS | 1655 | 08:23:41 INFO - TEST-INFO | 1655: exit 0 08:23:42 INFO - TEST-OK | kraken | took 60067ms 08:23:42 INFO - SUITE-END | took 1177s 08:23:42 INFO - Completed test suite (00:19:37) 08:23:42 INFO - javascript benchmark 08:23:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7158.224371564928, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2768.667759868816, 3268.967310326896, 3275.541424200612, 3291.91770205745, 3331.783434076785, 5336.786528538853, 5372.785088596452, 5458.263134476844, 5524.917126243105, 5525.4474552544725, 5459.099248623982, 5463.672179669213, 5469.425710300421, 5496.148097044955, 5496.983058134238, 4910.75446227689, 4917.557419832206, 4985.127602669537, 5089.389273287192, 5105.566026887719, 5054.267131265964, 5066.113430149709, 5118.9488105119035, 5122.769475373599, 5155.5360017598405, 4073.877783666495, 4109.465769449952, 4787.736674482902, 4886.9511304886855, 5035.093683137034, 4204.957950420518, 4993.325901003354, 5003.474635163292, 5016.272640467112, 5073.188289873602, 4905.043516514281, 4956.826511072131, 4999.675021123615, 5003.149464591028, 5007.574356179729, 5348.277982472394, 5353.197020446925, 5446.373667028263, 5452.863678408032, 5454.481824226692, 5870.148828419855, 5893.057110862284, 5905.025670764318, 5917.674527900964, 6002.729877155539, 6034.577579569432, 6060.212172417601, 6075.301340345873, 6090.056041313604, 6104.542159338023, 4676.625869930397, 5607.80372686954, 5619.80330688424, 5622.690752008638, 5634.521065709419, 6004.6097003695495, 6007.008843540854, 6065.059915713072, 6132.122542660378, 6194.442500175006, 5656.095024796013, 5754.424557544212, 5758.913616295759, 5800.216970708984, 5912.231409916683, 6029.849253768691, 6086.817395478142, 6106.126990750407, 6116.588446665303, 6144.846378840565, 5975.40245975399, 6026.0, 6030.758769649253, 6044.274687037496, 6068.302145253264, 6015.0977353396465, 6023.156758053876, 6045.576809623284, 6046.304674962347, 6051.57638965277, 4720.291956206596, 4741.95258047422, 4791.233402655558, 4805.735684537384, 4830.830920917751, 4285.0, 4297.935530967038, 4304.634106100953, 4328.5455027222315, 4339.652827773833, 5529.557635389159, 5530.972345138249, 5543.667379957215, 5544.750486228129, 5546.334439867161, 5790.305163380337, 5892.351841297454, 6070.666113363719, 6088.939110608837, 6109.480694140959, 5568.16477528374, 5580.665160090326, 5582.91625625616, 5583.274174357308, 5610.298712660918, 5270.736463176826, 5319.0, 5322.0, 5329.0, 5365.222042803772, 6017.428344307284, 6068.6358818471035, 6132.141360525156, 6238.438540531374, 6296.874062518724, 6033.034714445667, 6082.0, 6082.665453400105, 6124.448799608057, 6125.479334256638, 6207.348228435949, 6242.250929888442, 6266.717997690206, 6274.0, 6281.0, 5728.598998070095, 5742.684152371659, 5889.38161493037, 5940.3168635605725, 5981.0, 5961.374055724086, 5967.194428752063, 5991.370906054802, 6032.155498230339, 6042.486388657014, 5828.6502809831545, 5833.241678581757, 5834.241548598655, 5839.532837372915, 5849.298084229919, 5660.971695141498, 5701.287339082614, 5704.3154821421695, 5779.566532510163, 5819.330776960704, 5699.743511542073, 5715.5713321500225, 5731.627444216113, 5773.711314434346, 5781.075027995501, 5837.0, 5837.241158649348, 5850.327212370462, 5851.853703657443, 5862.296524417097, 5527.226188333717, 5692.345380281321, 5698.772049117989, 5714.514266287412, 5725.2843394575675], "value": 5476.9389909923, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [426.7439536278233, 491.91145593793124, 493.9654224204303, 523.7119584228676, 537.0574641504159, 29374.0, 39370.0, 40499.59500404995, 40567.59432405675, 40648.79675601625, 40739.79630101853, 41140.38289425661, 41197.794011029975, 41221.58778412215, 41466.378004329956, 7977.282044615983, 8141.267285944264, 9278.25773938085, 9471.242300615968, 9493.81012379752, 11006.119510439186, 11303.152263580265, 11316.547338106466, 11368.204225704205, 11375.715607109847, 11192.216544841864, 11278.0, 11279.154063445234, 11281.717957051098, 11310.264832785842, 11237.381943993078, 11278.041366483858, 11295.661130166109, 11322.716932076682, 11352.60265890694, 11153.832692509619, 11232.269902456314, 11237.044851187658, 11243.718907027307, 11268.0, 39254.60745392538, 39578.802105989285, 39623.405648915286, 39627.81116566507, 39648.81053568397, 3944.5069366329208, 3968.980155099206, 3969.186316805048, 4004.5394779600138, 4127.525334586531, 29087.127386178236, 30482.847585762152, 30548.8472557638, 30587.388252234832, 30930.0, 3117.812931224134, 3161.0674850919036, 3188.9681103189137, 3214.758893083028, 3223.9677603224136, 439792.0, 613913.0, 620287.0, 623653.0, 626940.0, 50279.497205028216, 60608.696956515814, 60773.0, 60906.0, 60939.39060609426, 62245.37754622487, 62531.0, 63195.6840215796, 63259.9392048635, 63387.04919426212, 15057.397704091714, 15482.0, 15953.68092638164, 15980.76028859568, 15998.360065597246, 12299.93850030744, 12363.949064329632, 12378.504859805687, 12385.752284954251, 12404.25574465535, 13354.0, 16199.43301984425, 16211.56826476038, 16249.943753655974, 16280.837191628169, 7076.540024898468, 7115.359617634334, 7136.571805691571, 7166.677499512534, 7187.604681742449, 796.7530065679658, 852.1691350932915, 857.3184318466834, 864.5893200729603, 872.8516152254132, 28005.438531596763, 28941.85529072341, 29460.263493412836, 30043.0, 30171.396572068435, 1013.9847902281472, 1024.4109636958779, 1059.7668512927144, 1061.474570087796, 1127.4193790198055, 12064.0, 14703.750181234715, 15169.848301517064, 15197.556232157927, 15491.690166196839, 613477.0, 613696.0, 613973.9301303554, 614891.0, 616624.0, 58149.0, 58316.708416458496, 58424.12363814546, 58504.0, 58537.12194317089, 1358.565259117073, 1370.5271681269946, 1378.076688618648, 1387.500499820064, 1397.2315226625315, 23893.0, 25442.872785635955, 28022.43955120927, 29077.273068173465, 29122.56316155217, 41755.0, 49617.255741163186, 49633.0, 49757.253641194686, 49997.0, 511603.0, 513729.0, 514459.0, 515855.0, 517502.41248793516, 24418.389540260923, 24824.0, 38109.618903811715, 38248.808755956044, 38465.61534384732, 40350.798246008584, 40992.0, 41075.0, 42155.15689686128, 42641.36037959495, 34185.31629367349, 34847.9545613632, 34960.9511714649, 35771.64228357683, 35836.82081589576, 34273.48589771205, 34280.0, 35093.0, 35353.646463535035, 35599.0, 34073.97778066662, 34238.65761342454, 34577.13557161091, 34755.0, 34757.13107172341, 29613.5557966635, 30943.690563094082, 31008.534871976488, 31296.923892071954, 31312.373752525276, 18951.71572426387, 23235.91094993013, 23267.341544906136, 23512.88243558771, 23540.882295588413], "value": 19707.18627754615, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.3906177473211, 347.37125802297845, 356.45818356098715, 395.43847736214565, 422.85200179937027, 14661.780073298896, 14879.553613391588, 15491.92254038731, 20461.283855065074, 21079.894600526975, 20653.483662908435, 21220.78779212211, 21691.0, 21807.345779626598, 21855.016524256407, 5958.8808223835495, 5961.105834124873, 6057.54568407369, 6211.47202487789, 6216.658083805389, 5991.400859914017, 6082.726277317509, 6094.756209751605, 6131.3868613138775, 6136.785212517563, 4010.498687664042, 4230.217409779185, 4263.488381394237, 6107.633541987473, 6713.731450741964, 6731.730730770763, 6744.426723728489, 6751.021101940191, 6764.458843292525, 6771.424428923498, 5619.7471113799975, 5671.9716401418145, 5815.098659707752, 5872.559558033165, 5887.470127688529, 20610.0, 26016.0, 26021.739782602122, 26667.733322666914, 26727.86636066807, 2692.690340610816, 2735.513916392186, 2736.616873637692, 2737.452509498108, 2783.318087068661, 15413.152276624782, 15561.144137072457, 15703.450379236787, 15848.683026339524, 16641.4175503858, 1820.681380758362, 1868.7944326124116, 1873.6065426260502, 1876.9812301876943, 1904.304928701028, 93333.0, 115436.42281788621, 115850.42074789573, 125716.37141814233, 129523.35238323842, 9383.24934005278, 10512.896145904722, 11014.559417623366, 11204.943975280072, 11388.316700997966, 14280.42878284857, 14309.0, 14344.641383965485, 14354.712905741826, 14364.856351436561, 8372.497650141011, 8538.487690738575, 8559.572021398904, 8572.742817715478, 8659.350548708871, 7495.887561686579, 7976.242256985577, 8393.538355390512, 8586.570671466401, 8638.481691098554, 6987.371136597731, 7110.5022648414115, 7119.288071192943, 7126.928730712731, 7138.785836424916, 1845.3541260558698, 1877.343558864192, 1880.2760937039338, 1886.415211284506, 1887.0941947865101, 877.5699907045629, 878.2841983783196, 887.1793590928365, 929.6374413978554, 935.5488619816125, 19670.70493942592, 21818.38070046318, 22834.200802971816, 23022.76977230206, 23100.65349019766, 860.6342304520554, 900.3922352412096, 910.1671970147241, 911.9876936600368, 924.8381533231658, 11059.944700276446, 11751.412429378497, 11814.763704725858, 11820.877016683402, 11865.88134118665, 627878.0, 712697.0, 741541.0, 756562.0, 758856.0, 129337.35331323283, 129980.70019299875, 130423.34788326187, 131515.0, 132045.0, 982.332014230316, 989.0900371658092, 1019.1133713669155, 1021.1830535571513, 1021.305512251676, 17970.460886173434, 19391.806081939, 19666.115024824205, 19706.50733731668, 19736.30922917691, 50866.23700644419, 55892.72053639706, 56100.0, 56685.0, 57302.426975731374, 63856.0, 77458.61270693611, 79603.20396796189, 80046.79929800941, 80173.19826801891, 5762.2221000164445, 7171.247019062923, 7374.373178279691, 8006.879896801669, 8346.707865224931, 13556.254406007763, 13691.315434228049, 13702.0, 14100.0, 14119.576412707635, 11618.121695740874, 11855.34795586251, 11882.881171188523, 11980.0, 12027.639170824888, 10815.56737730482, 11547.942260288644, 11552.480138393625, 11761.47073381717, 11976.28142311464, 11638.476268567765, 11638.592649257236, 11852.525898963944, 11960.043196544082, 12008.879911200776, 6803.625800581016, 8012.359011278967, 8201.917980820353, 8289.04675962272, 8482.57587120629, 11438.885611143782, 11679.941600291944, 11713.481601455727, 11855.34795586251, 11884.34636095023], "value": 9955.793625795715, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1086.3210493441595, 1104.00087920432, 1107.8836722144179, 1109.4840898981975, 1175.8530183727034, 8139.837203255931, 8316.542590157538, 8541.829163416744, 8559.015713192985, 8567.871481927768, 8357.540335281557, 8588.785280367994, 8595.355348348883, 8595.441296315736, 8613.52625605593, 2233.3188377544843, 2250.1112060736, 2256.537409830989, 2257.9322620321336, 2261.389424855288, 1992.1135094882711, 2070.9792902071013, 2253.278950735765, 2294.6558016297604, 2298.689676893615, 2019.7778244393105, 2189.5839790439763, 2259.412552736292, 2262.072550254396, 2262.694536237603, 2247.7415097263697, 2254.1772253127656, 2266.0369343029147, 2266.9206577769864, 2271.9091236350528, 2211.900464479102, 2267.1498188179435, 2269.364577918169, 2275.24916777463, 2277.8861056947085, 8570.228679418882, 8650.307975362019, 8658.480491170487, 8666.263367613761, 8678.262347700453, 4909.8772530686665, 5139.665921715076, 5153.407358153823, 5163.5352818246165, 5182.533571978503, 3192.9042128736173, 3418.9658103418897, 3422.3668621305137, 3424.9828750856336, 3504.526888869995, 1149.5976408257127, 1196.6888608961647, 1215.9574414895437, 1221.64483615909, 1236.9814452783216, 11171.273867198688, 11195.72010699739, 11272.436378181059, 11287.15346349019, 11303.491342889589, 4134.958650413518, 4349.0, 4427.67169849044, 4428.4536391574975, 4462.3752674625575, 8885.511296878605, 8887.555622218992, 8895.110488951053, 8900.688475903313, 8901.332400070021, 5093.898122037538, 5094.962015193878, 5104.081265372194, 5106.183010718267, 5107.336046313955, 4466.865994020184, 4519.0, 4567.703099298535, 4571.839985600488, 4651.325557794101, 3532.152283451953, 3578.534790477221, 3581.5164952731047, 3630.8184590770356, 3634.6910512606723, 1055.514463346869, 1143.7369405036889, 1146.7247860513417, 1154.4343271796927, 1155.8959693627614, 771.5842767389253, 878.3061381508537, 920.1672486399818, 932.9923682422967, 951.5429014601257, 5410.91883621746, 5497.697626630574, 5630.40880707528, 5634.690092044977, 5782.797602083907, 1010.8989101089979, 1012.8328825743818, 1036.740814796301, 1041.7812259425455, 1070.5182667799522, 3615.493830863681, 3687.963120368762, 3798.8290526925803, 3807.124361396894, 3838.1960478575024, 9743.512824358895, 10164.237682173867, 10173.54219060144, 10183.490825458697, 10212.693619191436, 9751.317407781387, 9782.021797820162, 10013.64952226683, 10117.595296188218, 10134.290599657954, 7715.768526944088, 7719.0, 7807.102183248886, 7909.169537198626, 7916.089649690244, 5401.4868587484125, 5434.83695489136, 5484.561235101262, 5538.113901775858, 5568.916466252928, 6970.51206415546, 9399.96600373972, 9406.341556091007, 9416.717498475056, 9442.38624489406, 7459.440541959266, 9388.389754665925, 9394.295427843075, 9508.619655213713, 9563.665271715456, 6623.701933412912, 7372.041634587469, 7386.482946193715, 7394.0, 7396.149442814145, 7972.0, 8044.3162331200165, 8046.839063218586, 8051.677932882619, 8054.879176812469, 7119.857602848017, 7158.713651453883, 7312.341889229995, 7349.0, 7375.37309328713, 7049.0, 7118.786436406916, 7129.215786263403, 7168.103987001625, 7194.532355396883, 5459.317585301837, 6365.1088847562305, 6403.007533832263, 6456.257530384066, 6543.051257567531, 5064.696118232918, 5069.543741063175, 5115.360579927509, 5121.871953201051, 5221.869453263699, 4964.1900388168815, 4973.875653108701, 5091.032703786269, 5267.236250743697, 5283.867903302448], "value": 4365.362359535511, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [287.657687352051, 346.82658670664665, 354.02466205603565, 357.4316836230393, 358.96769290763825, 4728.030753695497, 4895.804167833287, 4913.7788799504015, 5081.8221362252325, 5174.335217363061, 4746.477887432388, 5022.472640372763, 5042.647014708972, 5042.899142017158, 5081.745912704359, 3094.427530906778, 3621.026540535401, 3826.827792749326, 3881.592432794558, 3893.6301051400073, 3679.7737368891835, 3843.2121415109837, 3850.84596616135, 3879.456876037343, 3926.862559810407, 3859.282619234442, 3865.555461121965, 3876.282887665791, 3877.7091718121114, 3879.5538513070933, 2917.7957542972, 3110.9688903111132, 3418.658134186574, 3848.3842585186235, 3881.2454742939813, 3312.2216279174377, 3313.867445302185, 3314.552535407737, 3320.25294308781, 3463.4631632097066, 4266.87199384019, 4557.339185818071, 4617.5151609080895, 4950.0, 4989.675671081368, 4220.53574106848, 4345.174416860787, 4362.411074504965, 4366.345048242789, 4422.889427764299, 4380.474343078851, 5034.4713805050305, 5217.452167522393, 5305.840824775263, 5372.919406208871, 3189.6650851660474, 3675.246574452231, 3676.981615091934, 3695.981520092409, 3697.574778900434, 4720.315554244649, 4841.128596852565, 5372.0, 5500.074973759152, 5687.601867869251, 3015.728584427412, 3691.298653255873, 3701.3892707702926, 3720.0, 3789.1474418256225, 3073.938521229563, 3748.8125593720206, 3768.2840260350445, 3778.527684039495, 3782.5650050244026, 3517.56030496188, 3527.4885141654318, 3936.0946982194255, 4333.349997500401, 4356.390105385249, 4591.0, 4793.0, 5135.4094279157625, 5372.650777699515, 5372.677639341652, 1169.3626973299572, 1181.5805389086922, 1220.4812954494305, 1222.6882145052955, 1224.13086708438, 682.7200847652439, 763.023330137425, 775.3687909154295, 819.1399031017407, 831.2809419851785, 4412.646988240997, 4733.668643194943, 4747.172338649576, 4765.5949244314625, 4771.33201351811, 4539.6368290536675, 4693.413323334583, 5252.606054545848, 5277.02375060615, 5287.35632183908, 3966.874450571431, 4100.610442008005, 4701.576858082721, 4738.0, 4794.424669039668, 2230.910763569439, 2338.7427382987858, 2480.7395223501635, 2515.584928486779, 2769.529180039398, 4463.348561032439, 4770.752172610101, 5203.375594928632, 5286.603504737083, 5444.863878402993, 4472.39622650938, 4967.837901031265, 4986.0, 5352.732363381815, 5452.672839629635, 4694.929576056362, 4834.564889159992, 5093.8726531837, 5197.792088316425, 5431.755570999236, 4972.453030166606, 5084.669496482717, 5181.17101263811, 5191.402988656353, 5203.921941170961, 4074.714769966074, 4256.765537993947, 4611.93082103762, 4997.675151115166, 5161.922571161511, 5105.18317069282, 5676.829695109153, 5684.545236380997, 5717.656940583578, 5739.2252045973255, 3456.4469684850305, 3657.2868290684128, 3825.2923209206388, 3883.6893048555485, 4014.4580481634607, 5448.891022179613, 5482.725863706878, 5544.584156188383, 5550.833474995757, 5570.604640004837, 4518.88702782433, 5002.349694539832, 5370.409254981871, 5414.8646283841645, 5424.647397919122, 5330.866728331823, 5336.359636843604, 5384.3347542966485, 5394.892102158014, 5401.972990135024, 4182.853600123981, 4440.111977604427, 5308.362996440452, 5308.4160742317545, 5319.281896943863, 4072.3687828386646, 5058.570021548209, 5069.569086627678, 5327.653702509325, 5358.651687640291, 4443.644508439382, 4456.331550267486, 4949.851504454872, 5283.16590319853, 5292.867678308073], "value": 3799.1568910450424, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [704.6159842885627, 728.0171768113045, 743.5687301365208, 768.1742127213247, 818.3862103422431, 13804.240766757825, 14334.641633959156, 14579.48971785989, 14584.781228281585, 14592.41630334788, 13361.933190334035, 13549.390277437515, 13632.182069075863, 13663.795043074362, 13669.863301366984, 876.7325965580495, 880.5729221327651, 884.8363052835214, 900.8333458310217, 913.7213149989251, 877.6533269358599, 890.6882591093098, 890.9153630405101, 891.7012800711769, 891.8216356728648, 925.995295104812, 927.9536023198847, 930.1024511346549, 931.3666706639483, 932.6129656192705, 923.9907600923972, 926.7914719188196, 928.0023974227698, 928.2017464980112, 929.4562680831688, 691.6438034412282, 691.7267679266712, 692.0899017791588, 692.1210063219733, 695.6347917343385, 14491.927540362336, 14736.926315368355, 14827.481038163613, 14872.182029988346, 15170.620734481616, 11701.707457313636, 13474.797878031837, 13718.811249145909, 14011.509597164153, 14111.153330800082, 11404.942975285154, 11729.589464368792, 11859.58491452795, 12155.939220303842, 12414.81377779334, 3659.9085022874374, 3678.742488025839, 3689.631036896316, 3692.6216920470506, 3727.34771415004, 100388.0, 102969.0, 105296.0, 105747.47126264396, 106507.46746266374, 10762.515686794113, 10764.623238186627, 10868.67393978182, 10999.34003959765, 11206.215564910379, 21636.0, 21764.891175544337, 21966.670499942513, 22005.0, 22084.0, 7491.475596708178, 7510.511816731895, 7513.737019204411, 7589.544627322378, 7640.465167438226, 3719.6466335698065, 4014.698897582693, 4118.608732170439, 4124.7731374774075, 4275.87172384829, 3374.392609330344, 3375.1562109472634, 3459.1697992481622, 3485.076454739496, 3501.124718820295, 633.3856159525253, 634.2167423232304, 645.7481582182952, 651.5667081390822, 654.0810161722787, 626.764963138823, 642.8425035866243, 662.8541720821412, 672.8149758816364, 677.072410797211, 9270.30472714549, 9697.272704547046, 9838.212942964547, 9838.311318207656, 9912.702618921443, 638.409471239102, 662.1458318768734, 669.2270427656065, 683.0676127086491, 687.3470203306879, 4841.830535931225, 5372.382176049804, 5481.616286859881, 5506.229127922094, 5565.165225216169, 91886.0, 94869.5256523713, 97859.53210701846, 98856.0, 99339.00660993297, 88791.0, 88851.11148888429, 90452.09547904569, 90472.54763726139, 92095.1580968377, 78472.2152778465, 78531.0, 79221.20778792369, 79858.0, 80511.19488805154, 10819.729506762395, 11063.778724425627, 11154.832677510007, 11180.161487888603, 11373.431328433711, 47011.76494117644, 47293.527064728914, 47896.0, 48368.75815620899, 49318.0, 59945.0, 66229.66885165543, 66398.6680066616, 69327.96008059983, 71615.28384716086, 11207.439628018403, 13143.342832858127, 13328.733425331246, 13638.79541806854, 13705.862941370458, 14749.631259218606, 14968.326425311105, 15035.473758418402, 15044.473443429428, 15106.0, 13920.164790112625, 14003.859961400256, 14187.574372768833, 14610.0, 14634.853651463349, 13941.93029034889, 14052.0, 14054.859451405355, 14189.29053547298, 14306.213158276394, 13310.201387916755, 13405.128666636638, 14244.0, 14265.286735663383, 14267.785983210053, 11141.888581114084, 11215.934486223796, 11217.214794964275, 11589.130815188726, 11787.705307367385, 10841.975812675244, 11129.387883666475, 11191.38447385369, 11210.43947802623, 11322.60370887015], "value": 7548.0305751299375, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1448.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 112.0, 114.0, 112.0, 112.0, 113.0, 113.0, 113.0, 114.0, 116.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 108.0, 107.0, 143.0, 119.0, 140.0, 119.0, 116.0, 160.0, 141.0], "value": 129.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 181.0, 182.0, 186.0, 182.0, 181.0, 178.0, 182.0, 183.0, 185.0], "value": 182.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 69.0, 58.0, 85.0, 60.0, 59.0, 58.0, 58.0, 74.0, 56.0], "value": 65.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 71.0, 86.0, 71.0, 68.0, 69.0, 86.0, 68.0, 70.0, 83.0], "value": 75.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 84.0, 93.0, 131.0, 87.0, 84.0, 89.0, 85.0, 89.0, 84.0], "value": 91.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 98.0, 97.0, 97.0, 96.0, 97.0, 97.0, 97.0, 97.0, 97.0], "value": 97.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 87.0, 84.0, 86.0, 85.0, 85.0, 86.0, 87.0, 84.0], "value": 85.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 55.0, 56.0, 56.0, 57.0, 57.0, 57.0, 57.0, 57.0, 57.0], "value": 56.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 75.0, 68.0, 74.0, 70.0, 69.0, 67.0, 70.0, 70.0, 68.0], "value": 69.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 90.0, 84.0, 85.0, 86.0, 86.0, 85.0, 86.0, 87.0, 86.0], "value": 86.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 151.0, 151.0, 147.0, 126.0, 138.0, 137.0, 134.0, 178.0, 166.0], "value": 146.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 171.0, 172.0, 171.0, 174.0, 197.0, 237.0, 194.0, 172.0, 172.0], "value": 183.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 68.0, 64.0, 66.0, 65.0, 67.0, 59.0, 59.0, 78.0], "value": 65.9, "unit": "score"}]}]} 08:23:42 INFO - Return code: 0 08:23:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:23:42 ERROR - # TBPL SUCCESS # 08:23:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:23:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:23:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:23:42 INFO - 2017-02-04 08:23:42.225 screenresolution[1659:10144] starting screenresolution argv=screenresolution get 08:23:42 INFO - 2017-02-04 08:23:42.230 screenresolution[1659:10144] Display 0: 1600x1200x32@60 08:23:42 INFO - 2017-02-04 08:23:42.236 screenresolution[1660:10147] starting screenresolution argv=screenresolution list 08:23:42 INFO - Available Modes on Display 0 08:23:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:23:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:23:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:23:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:23:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:23:42 INFO - Intel Iris: 08:23:42 INFO - Chipset Model: Intel Iris 08:23:42 INFO - Type: GPU 08:23:42 INFO - Bus: Built-In 08:23:42 INFO - VRAM (Dynamic, Max): 1536 MB 08:23:42 INFO - Vendor: Intel (0x8086) 08:23:42 INFO - Device ID: 0x0a2e 08:23:42 INFO - Revision ID: 0x0009 08:23:42 INFO - Displays: 08:23:42 INFO - Display: 08:23:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:23:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:23:42 INFO - Display Serial Number: 1600x1200 60 08:23:42 INFO - Main Display: Yes 08:23:42 INFO - Mirror: Off 08:23:42 INFO - Online: Yes 08:23:42 INFO - Rotation: Supported 08:23:42 INFO - Return code: 0 08:23:42 INFO - Running post-action listener: _resource_record_post_action 08:23:42 INFO - [mozharness: 2017-02-04 16:23:42.479354Z] Finished run-tests step (success) 08:23:42 INFO - Running post-run listener: _resource_record_post_run 08:23:42 INFO - Total resource usage - Wall time: 1200s; CPU: 54.0%; Read bytes: 31624192; Write bytes: 554561536; Read time: 362; Write time: 1771 08:23:42 INFO - TinderboxPrint: CPU usage
53.8% 08:23:42 INFO - TinderboxPrint: I/O read bytes / time
31,624,192 / 362 08:23:42 INFO - TinderboxPrint: I/O write bytes / time
554,561,536 / 1,771 08:23:42 INFO - TinderboxPrint: CPU idle
2,216.5 (46.2%) 08:23:42 INFO - TinderboxPrint: CPU system
963.3 (20.1%) 08:23:42 INFO - TinderboxPrint: CPU user
1,621.9 (33.8%) 08:23:42 INFO - TinderboxPrint: Swap in / out
279,703,552 / 0 08:23:42 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 229437952; Write bytes: 225306624; Read time: 16359; Write time: 484 08:23:42 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 30702592; Write bytes: 299239424; Read time: 345; Write time: 1232 08:23:42 INFO - Running post-run listener: _upload_blobber_files 08:23:42 INFO - Blob upload gear active. 08:23:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:23:42 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:23:42 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:23:42 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:23:43 INFO - (blobuploader) - INFO - Open directory for files ... 08:23:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:23:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:23:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:23:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:23:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:23:44 INFO - (blobuploader) - INFO - Done attempting. 08:23:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:23:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:23:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:23:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:23:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:23:45 INFO - (blobuploader) - INFO - Done attempting. 08:23:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:23:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:23:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:23:46 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:23:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:23:46 INFO - (blobuploader) - INFO - Done attempting. 08:23:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:23:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:23:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:23:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:23:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:23:48 INFO - (blobuploader) - INFO - Done attempting. 08:23:48 INFO - (blobuploader) - INFO - Iteration through files over. 08:23:48 INFO - Return code: 0 08:23:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:23:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:23:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c2660ec29db4f23d255ad4d85c758d1bc4e05971d560593d2ea02d513cce627f30ac4d26c62e53babf4395ff6ed7be670e624e904c425ce9d37524dc4e97b1e3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/32ba59794f0458829a9936c917e6f070138abb3d3feadad28ed8faf43437b615f2ac134efe3303d772fa6ee9d068619f33114c4c1945b714fbf221a8c4560cf4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4758b2ac8bb8475cfc5984b6ea0486a49e9fc14854a0057a56808b35dff241e4b37da6935e373619f9decf8a390068992300c38dab136c35ec042f8ceba2d7c2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aefc164ff0bad6745205dcff943d52dd46fcd256c5675f3588d615dfcac23a274fef22a936bbbbd1e332a76ca6c9182263cf930058242a0d06ca6a19c58aef3e"} 08:23:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:23:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:23:48 INFO - Contents: 08:23:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c2660ec29db4f23d255ad4d85c758d1bc4e05971d560593d2ea02d513cce627f30ac4d26c62e53babf4395ff6ed7be670e624e904c425ce9d37524dc4e97b1e3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/32ba59794f0458829a9936c917e6f070138abb3d3feadad28ed8faf43437b615f2ac134efe3303d772fa6ee9d068619f33114c4c1945b714fbf221a8c4560cf4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4758b2ac8bb8475cfc5984b6ea0486a49e9fc14854a0057a56808b35dff241e4b37da6935e373619f9decf8a390068992300c38dab136c35ec042f8ceba2d7c2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aefc164ff0bad6745205dcff943d52dd46fcd256c5675f3588d615dfcac23a274fef22a936bbbbd1e332a76ca6c9182263cf930058242a0d06ca6a19c58aef3e"} 08:23:48 INFO - Running post-run listener: copy_logs_to_upload_dir 08:23:48 INFO - Copying logs to upload dir... 08:23:48 INFO - mkdir: /builds/slave/test/build/upload/logs 08:23:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.182475 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-02-04 08:23:48.958071) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-04 08:23:48.965653) ========= 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.Wf35rKklya/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.Arqgkmi4CW/Listeners TMPDIR=/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/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/Firefox/sha512/c2660ec29db4f23d255ad4d85c758d1bc4e05971d560593d2ea02d513cce627f30ac4d26c62e53babf4395ff6ed7be670e624e904c425ce9d37524dc4e97b1e3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/32ba59794f0458829a9936c917e6f070138abb3d3feadad28ed8faf43437b615f2ac134efe3303d772fa6ee9d068619f33114c4c1945b714fbf221a8c4560cf4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4758b2ac8bb8475cfc5984b6ea0486a49e9fc14854a0057a56808b35dff241e4b37da6935e373619f9decf8a390068992300c38dab136c35ec042f8ceba2d7c2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aefc164ff0bad6745205dcff943d52dd46fcd256c5675f3588d615dfcac23a274fef22a936bbbbd1e332a76ca6c9182263cf930058242a0d06ca6a19c58aef3e"} build_url:https://queue.taskcluster.net/v1/task/MX7yl3euQSaS67FMgKiaIA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011000 build_url: 'https://queue.taskcluster.net/v1/task/MX7yl3euQSaS67FMgKiaIA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c2660ec29db4f23d255ad4d85c758d1bc4e05971d560593d2ea02d513cce627f30ac4d26c62e53babf4395ff6ed7be670e624e904c425ce9d37524dc4e97b1e3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/32ba59794f0458829a9936c917e6f070138abb3d3feadad28ed8faf43437b615f2ac134efe3303d772fa6ee9d068619f33114c4c1945b714fbf221a8c4560cf4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4758b2ac8bb8475cfc5984b6ea0486a49e9fc14854a0057a56808b35dff241e4b37da6935e373619f9decf8a390068992300c38dab136c35ec042f8ceba2d7c2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aefc164ff0bad6745205dcff943d52dd46fcd256c5675f3588d615dfcac23a274fef22a936bbbbd1e332a76ca6c9182263cf930058242a0d06ca6a19c58aef3e"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-04 08:23:49.002738) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-04 08:23:49.003045) ========= 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.Wf35rKklya/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.Arqgkmi4CW/Listeners TMPDIR=/var/folders/ch/jbqcw7411bjcxr_98hzzbdlh00000w/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.005181 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-04 08:23:49.050656) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-04 08:23:49.050931) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-04 08:23:49.054223) ========= ========= Total master_lag: 0.20 =========