builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0312 starttime: 1485435376.59 results: success (0) buildid: 20170126030209 builduid: 7177aa7dfc684a94bde145e0d5e0ba18 revision: fbdfcecf0c774d2221f11aed5a504d5591c774e0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-26 04:56:16.601960) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-26 04:56:16.602454) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-26 04:56:16.602731) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-26 04:56:16.722132) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-26 04:56:16.722391) ========= 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.HTUOfOR6OQ/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.vEcROtkoL7/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-26 04:56:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 34.3M=0s 2017-01-26 04:56:17 (34.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.488374 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-26 04:56:17.234771) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-26 04:56:17.235091) ========= 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.HTUOfOR6OQ/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.vEcROtkoL7/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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.020267 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-26 04:56:17.286744) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-26 04:56:17.287837) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev fbdfcecf0c774d2221f11aed5a504d5591c774e0 --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 fbdfcecf0c774d2221f11aed5a504d5591c774e0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.HTUOfOR6OQ/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.vEcROtkoL7/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-26 04:56:17,380 truncating revision to first 12 chars 2017-01-26 04:56:17,380 Setting DEBUG logging. 2017-01-26 04:56:17,380 attempt 1/10 2017-01-26 04:56:17,380 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/fbdfcecf0c77?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-26 04:56:18,038 unpacking tar archive at: mozilla-central-fbdfcecf0c77/testing/mozharness/ program finished with exit code 0 elapsedTime=0.909213 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-26 04:56:18.223484) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-26 04:56:18.223809) ========= script_repo_revision: fbdfcecf0c774d2221f11aed5a504d5591c774e0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-26 04:56:18.224232) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-26 04:56:18.224572) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-26 04:56:18.245861) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-01-26 04:56:18.246299) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.HTUOfOR6OQ/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.vEcROtkoL7/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 04:56:18 INFO - MultiFileLogger online at 20170126 04:56:18 in /builds/slave/test 04:56:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:56:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:56:18 INFO - {'append_to_log': False, 04:56:18 INFO - 'base_work_dir': '/builds/slave/test', 04:56:18 INFO - 'blob_upload_branch': 'Firefox', 04:56:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:56:18 INFO - 'branch': 'Firefox', 04:56:18 INFO - 'buildbot_json_path': 'buildprops.json', 04:56:18 INFO - 'config_files': ('talos/mac_config.py',), 04:56:18 INFO - 'default_actions': ('clobber', 04:56:18 INFO - 'read-buildbot-config', 04:56:18 INFO - 'download-and-extract', 04:56:18 INFO - 'populate-webroot', 04:56:18 INFO - 'create-virtualenv', 04:56:18 INFO - 'install', 04:56:18 INFO - 'run-tests'), 04:56:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:56:18 INFO - 'download_minidump_stackwalk': True, 04:56:18 INFO - 'download_symbols': 'ondemand', 04:56:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:56:18 INFO - 'tooltool.py': '/tools/tooltool.py', 04:56:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:56:18 INFO - '/tools/misc-python/virtualenv.py')}, 04:56:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:56:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:56:18 INFO - 'installer_path': 'installer.exe', 04:56:18 INFO - 'log_level': 'info', 04:56:18 INFO - 'log_name': 'talos', 04:56:18 INFO - 'log_to_console': True, 04:56:18 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:56:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:56:18 INFO - 'opt_config_files': (), 04:56:18 INFO - 'pip_index': False, 04:56:18 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:56:18 INFO - 'cmd': ('bash', 04:56:18 INFO - '-c', 04:56:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:56:18 INFO - 'enabled': True, 04:56:18 INFO - 'halt_on_failure': False, 04:56:18 INFO - 'name': 'check_screen_resolution'},), 04:56:18 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:56:18 INFO - 'cmd': ('bash', 04:56:18 INFO - '-c', 04:56:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:56:18 INFO - 'enabled': True, 04:56:18 INFO - 'halt_on_failure': False, 04:56:18 INFO - 'name': 'check_screen_resolution'},), 04:56:18 INFO - 'run_cmd_checks_enabled': True, 04:56:18 INFO - 'sps_profile': False, 04:56:18 INFO - 'sps_profile_interval': 0, 04:56:18 INFO - 'suite': 'dromaeojs-e10s', 04:56:18 INFO - 'system_bits': '32', 04:56:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:56:18 INFO - 'title': 't-yosemite-r7-0312', 04:56:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:56:18 INFO - 'use_talos_json': True, 04:56:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:56:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:56:18 INFO - 'work_dir': 'build'} 04:56:18 INFO - [mozharness: 2017-01-26 12:56:18.452691Z] Running clobber step. 04:56:18 INFO - Running pre-action listener: _resource_record_pre_action 04:56:18 INFO - Running main action method: clobber 04:56:18 INFO - rmtree: /builds/slave/test/build 04:56:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:56:19 INFO - Running post-action listener: _resource_record_post_action 04:56:19 INFO - [mozharness: 2017-01-26 12:56:19.351467Z] Finished clobber step (success) 04:56:19 INFO - [mozharness: 2017-01-26 12:56:19.351635Z] Running read-buildbot-config step. 04:56:19 INFO - Running pre-action listener: _resource_record_pre_action 04:56:19 INFO - Running main action method: read_buildbot_config 04:56:19 INFO - Using buildbot properties: 04:56:19 INFO - { 04:56:19 INFO - "project": "", 04:56:19 INFO - "product": "firefox", 04:56:19 INFO - "script_repo_revision": "production", 04:56:19 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 04:56:19 INFO - "repository": "", 04:56:19 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 04:56:19 INFO - "buildid": "20170126030209", 04:56:19 INFO - "stage_platform": "macosx64", 04:56:19 INFO - "basedir": "/builds/slave/test", 04:56:19 INFO - "nightly_build": "True", 04:56:19 INFO - "buildnumber": 58, 04:56:19 INFO - "slavename": "t-yosemite-r7-0312", 04:56:19 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 04:56:19 INFO - "platform": "yosemite_r7", 04:56:19 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:56:19 INFO - "branch": "mozilla-central", 04:56:19 INFO - "repo_path": "mozilla-central", 04:56:19 INFO - "revision": "fbdfcecf0c774d2221f11aed5a504d5591c774e0", 04:56:19 INFO - "pgo_build": "False", 04:56:19 INFO - "builduid": "7177aa7dfc684a94bde145e0d5e0ba18", 04:56:19 INFO - "slavebuilddir": "test" 04:56:19 INFO - } 04:56:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/GzGlSoTBTU6Kp7CTkxdOlA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 04:56:19 INFO - Running post-action listener: _resource_record_post_action 04:56:19 INFO - [mozharness: 2017-01-26 12:56:19.355204Z] Finished read-buildbot-config step (success) 04:56:19 INFO - [mozharness: 2017-01-26 12:56:19.355330Z] Running download-and-extract step. 04:56:19 INFO - Running pre-action listener: _resource_record_pre_action 04:56:19 INFO - Running main action method: download_and_extract 04:56:19 INFO - mkdir: /builds/slave/test/build/tests 04:56:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:56:19 INFO - trying https://queue.taskcluster.net/v1/task/GzGlSoTBTU6Kp7CTkxdOlA/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 04:56:19 INFO - Downloading https://queue.taskcluster.net/v1/task/GzGlSoTBTU6Kp7CTkxdOlA/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 04:56:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GzGlSoTBTU6Kp7CTkxdOlA/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 04:56:19 INFO - Downloaded 1199 bytes. 04:56:19 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 04:56:19 INFO - Using the following test package requirements: 04:56:19 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 04:56:19 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:56:19 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 04:56:19 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:56:19 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 04:56:19 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:56:19 INFO - u'jsshell-mac.zip'], 04:56:19 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:56:19 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 04:56:19 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 04:56:19 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:56:19 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 04:56:19 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:56:19 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 04:56:19 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:56:19 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 04:56:19 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:56:19 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 04:56:19 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:56:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GzGlSoTBTU6Kp7CTkxdOlA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 04:56:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GzGlSoTBTU6Kp7CTkxdOlA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:56:19 INFO - Fetch https://queue.taskcluster.net/v1/task/GzGlSoTBTU6Kp7CTkxdOlA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 04:56:20 INFO - Expected file size: 16352053 04:56:20 INFO - Obtained file size: 16352053 04:56:27 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 04:56:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GzGlSoTBTU6Kp7CTkxdOlA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 04:56:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GzGlSoTBTU6Kp7CTkxdOlA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:56:27 INFO - Fetch https://queue.taskcluster.net/v1/task/GzGlSoTBTU6Kp7CTkxdOlA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 04:56:28 INFO - Expected file size: 16352053 04:56:28 INFO - Obtained file size: 16352053 04:56:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GzGlSoTBTU6Kp7CTkxdOlA/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 04:56:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GzGlSoTBTU6Kp7CTkxdOlA/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:56:34 INFO - Fetch https://queue.taskcluster.net/v1/task/GzGlSoTBTU6Kp7CTkxdOlA/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 04:56:35 INFO - Expected file size: 14403435 04:56:35 INFO - Obtained file size: 14403435 04:56: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')]} 04:56:35 INFO - trying https://queue.taskcluster.net/v1/task/GzGlSoTBTU6Kp7CTkxdOlA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 04:56:35 INFO - Downloading https://queue.taskcluster.net/v1/task/GzGlSoTBTU6Kp7CTkxdOlA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 04:56:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GzGlSoTBTU6Kp7CTkxdOlA/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 04:56:37 INFO - Downloaded 69956610 bytes. 04:56:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GzGlSoTBTU6Kp7CTkxdOlA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 04:56:37 INFO - mkdir: /builds/slave/test/properties 04:56:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:56:37 INFO - Writing to file /builds/slave/test/properties/build_url 04:56:37 INFO - Contents: 04:56:37 INFO - build_url:https://queue.taskcluster.net/v1/task/GzGlSoTBTU6Kp7CTkxdOlA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 04:56:38 INFO - Running post-action listener: _resource_record_post_action 04:56:38 INFO - Running post-action listener: set_extra_try_arguments 04:56:38 INFO - [mozharness: 2017-01-26 12:56:38.685547Z] Finished download-and-extract step (success) 04:56:38 INFO - [mozharness: 2017-01-26 12:56:38.685690Z] Running populate-webroot step. 04:56:38 INFO - Running pre-action listener: _resource_record_pre_action 04:56:38 INFO - Running main action method: populate_webroot 04:56:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:56:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:56:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:56:38 INFO - '--tppagecycles', 04:56:38 INFO - '7'], 04:56:38 INFO - 'tests': ['tsvgm']}}, 04:56:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:56:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:56:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:56:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:56:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:56:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:56:38 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:56:38 INFO - 'talos_options': ['--disable-e10s'], 04:56:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:56:38 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:56:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:56:38 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:56:38 INFO - 'talos_options': ['--disable-e10s'], 04:56:38 INFO - 'tests': ['damp', 'tps']}, 04:56:38 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:56:38 INFO - 'tests': ['damp', 'tps']}, 04:56:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:56:38 INFO - 'tests': ['dromaeo_dom']}, 04:56:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:56:38 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:56:38 INFO - 'tests': ['basic_compositor_video']}, 04:56:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:56:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:56:38 INFO - 'tests': ['a11yr', 04:56:38 INFO - 'ts_paint', 04:56:38 INFO - 'tpaint', 04:56:38 INFO - 'sessionrestore', 04:56:38 INFO - 'sessionrestore_no_auto_restore', 04:56:38 INFO - 'tabpaint']}, 04:56:38 INFO - 'other-e10s': {'tests': ['a11yr', 04:56:38 INFO - 'ts_paint', 04:56:38 INFO - 'tpaint', 04:56:38 INFO - 'sessionrestore', 04:56:38 INFO - 'sessionrestore_no_auto_restore', 04:56:38 INFO - 'tabpaint']}, 04:56:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:56:38 INFO - 'ts_paint', 04:56:38 INFO - 'tpaint', 04:56:38 INFO - 'sessionrestore', 04:56:38 INFO - 'sessionrestore_no_auto_restore', 04:56:38 INFO - 'tabpaint']}, 04:56:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:56:38 INFO - 'ts_paint', 04:56:38 INFO - 'tpaint', 04:56:38 INFO - 'sessionrestore', 04:56:38 INFO - 'sessionrestore_no_auto_restore', 04:56:38 INFO - 'tabpaint']}, 04:56:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:56:38 INFO - 'tests': ['a11yr', 04:56:38 INFO - 'ts_paint', 04:56:38 INFO - 'tpaint', 04:56:38 INFO - 'sessionrestore', 04:56:38 INFO - 'sessionrestore_no_auto_restore', 04:56:38 INFO - 'tabpaint']}, 04:56:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:56:38 INFO - 'tests': ['a11yr', 04:56:38 INFO - 'ts_paint', 04:56:38 INFO - 'tpaint', 04:56:38 INFO - 'sessionrestore', 04:56:38 INFO - 'sessionrestore_no_auto_restore', 04:56:38 INFO - 'tabpaint']}, 04:56:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:56:38 INFO - 'tests': ['tsvgx', 04:56:38 INFO - 'tsvgr_opacity', 04:56:38 INFO - 'tart', 04:56:38 INFO - 'tscrollx', 04:56:38 INFO - 'cart', 04:56:38 INFO - 'tsvg_static']}, 04:56:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:56:38 INFO - 'tsvgr_opacity', 04:56:38 INFO - 'tart', 04:56:38 INFO - 'tscrollx', 04:56:38 INFO - 'cart', 04:56:38 INFO - 'tsvg_static']}, 04:56:38 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:56:38 INFO - 'talos_options': ['--disable-e10s'], 04:56:38 INFO - 'tests': ['tp5o']}, 04:56:38 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:56:38 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:56:38 INFO - 'talos_options': ['--disable-e10s', 04:56:38 INFO - '--xperf_path', 04:56:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:56:38 INFO - 'tests': ['tp5n']}, 04:56:38 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:56:38 INFO - 'talos_options': ['--xperf_path', 04:56:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:56:38 INFO - 'tests': ['tp5n']}}, 04:56:38 INFO - 'talos.zip': {'path': '', 04:56:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:56:38 INFO - Running post-action listener: _resource_record_post_action 04:56:38 INFO - [mozharness: 2017-01-26 12:56:38.704193Z] Finished populate-webroot step (success) 04:56:38 INFO - [mozharness: 2017-01-26 12:56:38.704327Z] Running create-virtualenv step. 04:56:38 INFO - Running pre-action listener: _resource_record_pre_action 04:56:38 INFO - Running main action method: create_virtualenv 04:56:38 INFO - Creating virtualenv /builds/slave/test/build/venv 04:56:38 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 04:56:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:56:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:56:38 INFO - Using real prefix '/tools/python27' 04:56:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:56:39 INFO - Installing distribute.............................................................................................................................................................................................done. 04:56:42 INFO - Installing pip.................done. 04:56:42 INFO - Return code: 0 04:56:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:56:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:56:42 INFO - Reading from file tmpfile_stdout 04:56:42 INFO - Output received: 04:56:42 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) 04:56:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:56:42 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')]} 04:56:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:42 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')]} 04:56:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:42 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 0x106fafb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106fb2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca7b5684a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d8dd30>, '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 0x106cb4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106d82be8>, '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.HTUOfOR6OQ/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.vEcROtkoL7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 04:56:42 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 04:56:42 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 04:56:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HTUOfOR6OQ/Render', 04:56:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:56:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:56:42 INFO - 'HOME': '/Users/cltbld', 04:56:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:56:42 INFO - 'LOGNAME': 'cltbld', 04:56:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:42 INFO - 'MOZ_NO_REMOTE': '1', 04:56:42 INFO - 'NO_EM_RESTART': '1', 04:56:42 INFO - 'PAGER': '/bin/cat', 04:56:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:56:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:42 INFO - 'PWD': '/builds/slave/test', 04:56:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:56:42 INFO - 'SHELL': '/bin/bash', 04:56:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vEcROtkoL7/Listeners', 04:56:42 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 04:56:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:56:42 INFO - 'USER': 'cltbld', 04:56:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:56:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:56:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:42 INFO - 'XPC_FLAGS': '0x0', 04:56:42 INFO - 'XPC_SERVICE_NAME': '0', 04:56:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:56:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:42 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 04:56:42 INFO - Cleaning up... 04:56:42 INFO - Return code: 0 04:56:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:56:42 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')]} 04:56:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:42 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')]} 04:56:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:42 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 0x106fafb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106fb2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca7b5684a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d8dd30>, '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 0x106cb4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106d82be8>, '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.HTUOfOR6OQ/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.vEcROtkoL7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 04:56:42 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 04:56:42 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 04:56:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HTUOfOR6OQ/Render', 04:56:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:56:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:56:42 INFO - 'HOME': '/Users/cltbld', 04:56:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:56:42 INFO - 'LOGNAME': 'cltbld', 04:56:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:42 INFO - 'MOZ_NO_REMOTE': '1', 04:56:42 INFO - 'NO_EM_RESTART': '1', 04:56:42 INFO - 'PAGER': '/bin/cat', 04:56:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:56:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:42 INFO - 'PWD': '/builds/slave/test', 04:56:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:56:42 INFO - 'SHELL': '/bin/bash', 04:56:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vEcROtkoL7/Listeners', 04:56:42 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 04:56:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:56:42 INFO - 'USER': 'cltbld', 04:56:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:56:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:56:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:42 INFO - 'XPC_FLAGS': '0x0', 04:56:42 INFO - 'XPC_SERVICE_NAME': '0', 04:56:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:56:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:43 INFO - Downloading/unpacking psutil>=3.1.1 04:56:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:56:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:56:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:56:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:56:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:56:46 INFO - Installing collected packages: psutil 04:56:46 INFO - Running setup.py install for psutil 04:56:47 INFO - building 'psutil._psutil_osx' extension 04:56:47 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 04:56:47 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 04:56:47 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 04:56:47 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 04:56:47 INFO - building 'psutil._psutil_posix' extension 04:56:47 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 04:56:47 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:56:47 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:56:47 INFO - ^ 04:56:47 INFO - 1 warning generated. 04:56:47 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 04:56:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:56:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:56:47 INFO - Successfully installed psutil 04:56:47 INFO - Cleaning up... 04:56:47 INFO - Return code: 0 04:56:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:56: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')]} 04:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56: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')]} 04:56:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106fafb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106fb2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca7b5684a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d8dd30>, '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 0x106cb4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106d82be8>, '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.HTUOfOR6OQ/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.vEcROtkoL7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 04:56:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:56:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:56:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HTUOfOR6OQ/Render', 04:56:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:56:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:56:47 INFO - 'HOME': '/Users/cltbld', 04:56:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:56:47 INFO - 'LOGNAME': 'cltbld', 04:56:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:47 INFO - 'MOZ_NO_REMOTE': '1', 04:56:47 INFO - 'NO_EM_RESTART': '1', 04:56:47 INFO - 'PAGER': '/bin/cat', 04:56:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:56:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:47 INFO - 'PWD': '/builds/slave/test', 04:56:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:56:47 INFO - 'SHELL': '/bin/bash', 04:56:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vEcROtkoL7/Listeners', 04:56:47 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 04:56:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:56:47 INFO - 'USER': 'cltbld', 04:56:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:56:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:56:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:47 INFO - 'XPC_FLAGS': '0x0', 04:56:47 INFO - 'XPC_SERVICE_NAME': '0', 04:56:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:56:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:56:48 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 04:56:48 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 04:56:48 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 04:56:48 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 04:56:48 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 04:56:48 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 04:56:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:56:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:56:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:56:50 INFO - Installing collected packages: mozsystemmonitor 04:56:50 INFO - Running setup.py install for mozsystemmonitor 04:56:50 INFO - Successfully installed mozsystemmonitor 04:56:50 INFO - Cleaning up... 04:56:50 INFO - Return code: 0 04:56:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:56:50 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')]} 04:56:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:50 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')]} 04:56:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:50 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 0x106fafb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106fb2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca7b5684a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d8dd30>, '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 0x106cb4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106d82be8>, '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.HTUOfOR6OQ/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.vEcROtkoL7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 04:56:50 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 04:56:50 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 04:56:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HTUOfOR6OQ/Render', 04:56:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:56:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:56:50 INFO - 'HOME': '/Users/cltbld', 04:56:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:56:50 INFO - 'LOGNAME': 'cltbld', 04:56:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:50 INFO - 'MOZ_NO_REMOTE': '1', 04:56:50 INFO - 'NO_EM_RESTART': '1', 04:56:50 INFO - 'PAGER': '/bin/cat', 04:56:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:56:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:50 INFO - 'PWD': '/builds/slave/test', 04:56:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:56:50 INFO - 'SHELL': '/bin/bash', 04:56:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vEcROtkoL7/Listeners', 04:56:50 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 04:56:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:56:50 INFO - 'USER': 'cltbld', 04:56:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:56:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:56:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:50 INFO - 'XPC_FLAGS': '0x0', 04:56:50 INFO - 'XPC_SERVICE_NAME': '0', 04:56:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:56:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:51 INFO - Downloading/unpacking jsonschema==2.5.1 04:56:51 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 04:56:51 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 04:56:51 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 04:56:51 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 04:56:51 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 04:56:51 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 04:56:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:56:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:56:53 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 04:56:53 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 04:56:53 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 04:56:53 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 04:56:53 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 04:56:53 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 04:56:54 INFO - Downloading functools32-3.2.3-2.tar.gz 04:56:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:56:54 INFO - warning: no files found matching '*.txt' 04:56:54 INFO - no previously-included directories found matching 'build' 04:56:54 INFO - no previously-included directories found matching 'dist' 04:56:54 INFO - no previously-included directories found matching '.git*' 04:56:54 INFO - Installing collected packages: jsonschema, functools32 04:56:54 INFO - Running setup.py install for functools32 04:56:54 INFO - warning: no files found matching '*.txt' 04:56:54 INFO - no previously-included directories found matching 'build' 04:56:54 INFO - no previously-included directories found matching 'dist' 04:56:54 INFO - no previously-included directories found matching '.git*' 04:56:54 INFO - Successfully installed jsonschema functools32 04:56:54 INFO - Cleaning up... 04:56:54 INFO - Return code: 0 04:56:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:56:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:56:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:56:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x106fafb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106fb2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca7b5684a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d8dd30>, '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 0x106cb4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106d82be8>, '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.HTUOfOR6OQ/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.vEcROtkoL7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 04:56:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:56:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:56:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HTUOfOR6OQ/Render', 04:56:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:56:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:56:54 INFO - 'HOME': '/Users/cltbld', 04:56:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:56:54 INFO - 'LOGNAME': 'cltbld', 04:56:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:54 INFO - 'MOZ_NO_REMOTE': '1', 04:56:54 INFO - 'NO_EM_RESTART': '1', 04:56:54 INFO - 'PAGER': '/bin/cat', 04:56:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:56:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:54 INFO - 'PWD': '/builds/slave/test', 04:56:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:56:54 INFO - 'SHELL': '/bin/bash', 04:56:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vEcROtkoL7/Listeners', 04:56:54 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 04:56:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:56:54 INFO - 'USER': 'cltbld', 04:56:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:56:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:56:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:54 INFO - 'XPC_FLAGS': '0x0', 04:56:54 INFO - 'XPC_SERVICE_NAME': '0', 04:56:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:56:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:56:54 INFO - Cleaning up... 04:56:54 INFO - Return code: 0 04:56:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:56:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:56:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:56:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x106fafb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106fb2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca7b5684a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d8dd30>, '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 0x106cb4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106d82be8>, '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.HTUOfOR6OQ/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.vEcROtkoL7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 04:56:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:56:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:56:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HTUOfOR6OQ/Render', 04:56:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:56:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:56:54 INFO - 'HOME': '/Users/cltbld', 04:56:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:56:54 INFO - 'LOGNAME': 'cltbld', 04:56:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:54 INFO - 'MOZ_NO_REMOTE': '1', 04:56:54 INFO - 'NO_EM_RESTART': '1', 04:56:54 INFO - 'PAGER': '/bin/cat', 04:56:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:56:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:54 INFO - 'PWD': '/builds/slave/test', 04:56:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:56:54 INFO - 'SHELL': '/bin/bash', 04:56:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vEcROtkoL7/Listeners', 04:56:54 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 04:56:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:56:54 INFO - 'USER': 'cltbld', 04:56:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:56:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:56:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:54 INFO - 'XPC_FLAGS': '0x0', 04:56:54 INFO - 'XPC_SERVICE_NAME': '0', 04:56:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:56:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:55 INFO - Downloading/unpacking blobuploader==1.2.4 04:56:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:56:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:56:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:57 INFO - Downloading blobuploader-1.2.4.tar.gz 04:56:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:56:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:56:57 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 04:56:57 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 04:56:57 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 04:56:57 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 04:56:57 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 04:56:57 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 04:56:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:56:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:56:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:56:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:56:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:59 INFO - Downloading docopt-0.6.1.tar.gz 04:56:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:56:59 INFO - Installing collected packages: blobuploader, requests, docopt 04:56:59 INFO - Running setup.py install for blobuploader 04:56:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:56:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:56:59 INFO - Running setup.py install for requests 04:56:59 INFO - Running setup.py install for docopt 04:56:59 INFO - Successfully installed blobuploader requests docopt 04:56:59 INFO - Cleaning up... 04:57:00 INFO - Return code: 0 04:57:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:57:00 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')]} 04:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:00 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')]} 04:57:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:00 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 0x106fafb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106fb2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca7b5684a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d8dd30>, '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 0x106cb4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106d82be8>, '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.HTUOfOR6OQ/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.vEcROtkoL7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 04:57:00 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 04:57:00 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 04:57:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HTUOfOR6OQ/Render', 04:57:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:57:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:57:00 INFO - 'HOME': '/Users/cltbld', 04:57:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:57:00 INFO - 'LOGNAME': 'cltbld', 04:57:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:00 INFO - 'MOZ_NO_REMOTE': '1', 04:57:00 INFO - 'NO_EM_RESTART': '1', 04:57:00 INFO - 'PAGER': '/bin/cat', 04:57:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:57:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:00 INFO - 'PWD': '/builds/slave/test', 04:57:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:57:00 INFO - 'SHELL': '/bin/bash', 04:57:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vEcROtkoL7/Listeners', 04:57:00 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 04:57:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:57:00 INFO - 'USER': 'cltbld', 04:57:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:57:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:57:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:00 INFO - 'XPC_FLAGS': '0x0', 04:57:00 INFO - 'XPC_SERVICE_NAME': '0', 04:57:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:57:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:57:00 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-Af_vF1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:57:00 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-973Aht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:57:00 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-8ULpPM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:57:00 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-BWt61q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:57:00 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-hedzB4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:57:00 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-q98oPW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:57:00 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-hB5vph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:57:01 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-SNLfN_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:57:01 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-6U2Igy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:57:01 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-4iWHWq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:57:01 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-jhxCcx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:57:01 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-QIe8ov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:57:01 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-XA37Mv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:57:01 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-JaBq7g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:57:01 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-6kz2ha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:57:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:57:01 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-fq46r4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:57:02 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-5aXmCY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:57:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:57:02 INFO - Running setup.py install for manifestparser 04:57:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:57:02 INFO - Running setup.py install for mozcrash 04:57:02 INFO - Running setup.py install for mozdebug 04:57:02 INFO - Running setup.py install for mozdevice 04:57:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:57:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:57:02 INFO - Running setup.py install for mozfile 04:57:02 INFO - Running setup.py install for mozhttpd 04:57:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:57:03 INFO - Running setup.py install for mozinfo 04:57:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:57:03 INFO - Running setup.py install for mozInstall 04:57:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:57:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:57:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:57:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:57:03 INFO - Running setup.py install for mozleak 04:57:03 INFO - Running setup.py install for mozlog 04:57:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:57:03 INFO - Running setup.py install for moznetwork 04:57:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:57:03 INFO - Running setup.py install for mozprocess 04:57:03 INFO - Running setup.py install for mozprofile 04:57:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:57:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:57:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:57:04 INFO - Running setup.py install for mozrunner 04:57:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:57:04 INFO - Running setup.py install for mozscreenshot 04:57:04 INFO - Running setup.py install for moztest 04:57:04 INFO - Running setup.py install for mozversion 04:57:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:57:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:57:04 INFO - Cleaning up... 04:57:04 INFO - Return code: 0 04:57:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:57:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:57:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:57:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:04 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 0x106fafb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106fb2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca7b5684a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d8dd30>, '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 0x106cb4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106d82be8>, '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.HTUOfOR6OQ/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.vEcROtkoL7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 04:57:04 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 04:57:04 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 04:57:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HTUOfOR6OQ/Render', 04:57:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:57:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:57:04 INFO - 'HOME': '/Users/cltbld', 04:57:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:57:04 INFO - 'LOGNAME': 'cltbld', 04:57:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:04 INFO - 'MOZ_NO_REMOTE': '1', 04:57:04 INFO - 'NO_EM_RESTART': '1', 04:57:04 INFO - 'PAGER': '/bin/cat', 04:57:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:57:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:04 INFO - 'PWD': '/builds/slave/test', 04:57:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:57:04 INFO - 'SHELL': '/bin/bash', 04:57:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vEcROtkoL7/Listeners', 04:57:04 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 04:57:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:57:04 INFO - 'USER': 'cltbld', 04:57:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:57:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:57:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:04 INFO - 'XPC_FLAGS': '0x0', 04:57:04 INFO - 'XPC_SERVICE_NAME': '0', 04:57:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:57:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:57:05 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-NPGigG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:57:05 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)) 04:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:57:05 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-TUHOO_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:57:05 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)) 04:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:57:05 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-ErpJLx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:57:05 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)) 04:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:57:05 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-xcnIVd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:57:05 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)) 04:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:57:05 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-jeJic7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:57:05 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)) 04:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:57:05 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-cSPCe7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:57:05 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)) 04:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:57:05 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-P3mnwq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:57:05 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)) 04:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:57:05 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-n2qRYc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:57:05 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)) 04:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:57:05 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-v8HyUo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:57:05 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)) 04:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:57:06 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-tw_ILB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:57:06 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)) 04:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:57:06 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-xE9BqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:57:06 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)) 04:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:57:06 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-P0mZoq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:57:06 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)) 04:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:57:06 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-r3UiDY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:57:06 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)) 04:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:57:06 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-NBV72t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:57:06 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)) 04:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:57:06 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-LTZHXF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:57:06 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)) 04:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:57:06 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-SYovwW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:57:06 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)) 04:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:57:06 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-9x85OJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:57:06 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)) 04:57:06 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)) 04:57:06 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)) 04:57:06 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)) 04:57:06 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)) 04:57:06 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)) 04:57:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:09 INFO - Downloading blessings-1.6.tar.gz 04:57:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:57:09 INFO - Installing collected packages: blessings 04:57:09 INFO - Running setup.py install for blessings 04:57:09 INFO - Successfully installed blessings 04:57:09 INFO - Cleaning up... 04:57:09 INFO - Return code: 0 04:57:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:57:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:57:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:57:10 INFO - Reading from file tmpfile_stdout 04:57:10 INFO - Current package versions: 04:57:10 INFO - blessings == 1.6 04:57:10 INFO - blobuploader == 1.2.4 04:57:10 INFO - docopt == 0.6.1 04:57:10 INFO - functools32 == 3.2.3-2 04:57:10 INFO - jsonschema == 2.5.1 04:57:10 INFO - manifestparser == 1.1 04:57:10 INFO - mozInstall == 1.12 04:57:10 INFO - mozcrash == 1.0 04:57:10 INFO - mozdebug == 0.1 04:57:10 INFO - mozdevice == 0.49 04:57:10 INFO - mozfile == 1.2 04:57:10 INFO - mozhttpd == 0.7 04:57:10 INFO - mozinfo == 0.9 04:57:10 INFO - mozleak == 0.1 04:57:10 INFO - mozlog == 3.4 04:57:10 INFO - moznetwork == 0.27 04:57:10 INFO - mozprocess == 0.24 04:57:10 INFO - mozprofile == 0.28 04:57:10 INFO - mozrunner == 6.13 04:57:10 INFO - mozscreenshot == 0.1 04:57:10 INFO - mozsystemmonitor == 0.3 04:57:10 INFO - moztest == 0.8 04:57:10 INFO - mozversion == 1.4 04:57:10 INFO - psutil == 3.1.1 04:57:10 INFO - requests == 1.2.3 04:57:10 INFO - wsgiref == 0.1.2 04:57:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:57:10 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')]} 04:57:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:10 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')]} 04:57:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:10 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 0x106fafb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106fb2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca7b5684a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d8dd30>, '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 0x106cb4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106d82be8>, '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.HTUOfOR6OQ/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.vEcROtkoL7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 04:57:10 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 04:57:10 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 04:57:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HTUOfOR6OQ/Render', 04:57:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:57:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:57:10 INFO - 'HOME': '/Users/cltbld', 04:57:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:57:10 INFO - 'LOGNAME': 'cltbld', 04:57:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:10 INFO - 'MOZ_NO_REMOTE': '1', 04:57:10 INFO - 'NO_EM_RESTART': '1', 04:57:10 INFO - 'PAGER': '/bin/cat', 04:57:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:57:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:10 INFO - 'PWD': '/builds/slave/test', 04:57:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:57:10 INFO - 'SHELL': '/bin/bash', 04:57:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vEcROtkoL7/Listeners', 04:57:10 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 04:57:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:57:10 INFO - 'USER': 'cltbld', 04:57:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:57:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:57:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:10 INFO - 'XPC_FLAGS': '0x0', 04:57:10 INFO - 'XPC_SERVICE_NAME': '0', 04:57:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:57:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:10 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)) 04:57:10 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)) 04:57:10 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)) 04:57:10 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)) 04:57:10 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)) 04:57:10 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)) 04:57:10 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)) 04:57:10 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)) 04:57:10 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)) 04:57:10 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)) 04:57:10 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)) 04:57:10 INFO - Cleaning up... 04:57:10 INFO - Return code: 0 04:57:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:57:10 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')]} 04:57:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:10 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')]} 04:57:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:10 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 0x106fafb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106fb2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca7b5684a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d8dd30>, '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 0x106cb4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106d82be8>, '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.HTUOfOR6OQ/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.vEcROtkoL7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 04:57:10 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 04:57:10 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 04:57:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HTUOfOR6OQ/Render', 04:57:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:57:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:57:10 INFO - 'HOME': '/Users/cltbld', 04:57:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:57:10 INFO - 'LOGNAME': 'cltbld', 04:57:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:10 INFO - 'MOZ_NO_REMOTE': '1', 04:57:10 INFO - 'NO_EM_RESTART': '1', 04:57:10 INFO - 'PAGER': '/bin/cat', 04:57:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:57:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:10 INFO - 'PWD': '/builds/slave/test', 04:57:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:57:10 INFO - 'SHELL': '/bin/bash', 04:57:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vEcROtkoL7/Listeners', 04:57:10 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 04:57:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:57:10 INFO - 'USER': 'cltbld', 04:57:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:57:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:57:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:10 INFO - 'XPC_FLAGS': '0x0', 04:57:10 INFO - 'XPC_SERVICE_NAME': '0', 04:57:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:57:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:57:10 INFO - Cleaning up... 04:57:10 INFO - Return code: 0 04:57:10 INFO - Running post-action listener: _resource_record_post_action 04:57:10 INFO - Running post-action listener: _start_resource_monitoring 04:57:10 INFO - Starting resource monitoring. 04:57:10 INFO - [mozharness: 2017-01-26 12:57:10.629242Z] Finished create-virtualenv step (success) 04:57:10 INFO - [mozharness: 2017-01-26 12:57:10.630110Z] Running install step. 04:57:10 INFO - Running pre-action listener: _resource_record_pre_action 04:57:10 INFO - Running main action method: install 04:57:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:57:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:57:10 INFO - Reading from file tmpfile_stdout 04:57:10 INFO - Detecting whether we're running mozinstall >=1.0... 04:57:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:57:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:57:10 INFO - Reading from file tmpfile_stdout 04:57:10 INFO - Output received: 04:57:10 INFO - Usage: mozinstall [options] installer 04:57:10 INFO - Options: 04:57:10 INFO - -h, --help show this help message and exit 04:57:10 INFO - -d DEST, --destination=DEST 04:57:10 INFO - Directory to install application into. [default: 04:57:10 INFO - "/builds/slave/test"] 04:57:10 INFO - --app=APP Application being installed. [default: firefox] 04:57:10 INFO - mkdir: /builds/slave/test/build/application 04:57:10 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'] 04:57:10 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 04:57:32 INFO - Reading from file tmpfile_stdout 04:57:32 INFO - Output received: 04:57:32 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 04:57:32 INFO - Running post-action listener: _resource_record_post_action 04:57:32 INFO - [mozharness: 2017-01-26 12:57:32.759032Z] Finished install step (success) 04:57:32 INFO - [mozharness: 2017-01-26 12:57:32.759184Z] Running run-tests step. 04:57:32 INFO - Running pre-action listener: _resource_record_pre_action 04:57:32 INFO - Running main action method: run_tests 04:57:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:57:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:57:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:57:32 INFO - 2017-01-26 04:57:32.774 screenresolution[1900:16328] starting screenresolution argv=screenresolution get 04:57:32 INFO - 2017-01-26 04:57:32.776 screenresolution[1900:16328] Display 0: 1600x1200x32@60 04:57:32 INFO - 2017-01-26 04:57:32.782 screenresolution[1901:16330] starting screenresolution argv=screenresolution list 04:57:32 INFO - Available Modes on Display 0 04:57:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:57:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:57:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:57:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:57:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:57:33 INFO - Intel Iris: 04:57:33 INFO - Chipset Model: Intel Iris 04:57:33 INFO - Type: GPU 04:57:33 INFO - Bus: Built-In 04:57:33 INFO - VRAM (Dynamic, Max): 1536 MB 04:57:33 INFO - Vendor: Intel (0x8086) 04:57:33 INFO - Device ID: 0x0a2e 04:57:33 INFO - Revision ID: 0x0009 04:57:33 INFO - Displays: 04:57:33 INFO - Display: 04:57:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:57:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:57:33 INFO - Display Serial Number: 1600x1200 60 04:57:33 INFO - Main Display: Yes 04:57:33 INFO - Mirror: Off 04:57:33 INFO - Online: Yes 04:57:33 INFO - Rotation: Supported 04:57:33 INFO - Return code: 0 04:57:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:57:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:57:33 INFO - Python 2.7.3 04:57:33 INFO - Return code: 0 04:57:33 INFO - grabbing minidump binary from tooltool 04:57:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:57:33 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 0x106d8dd30>, '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 0x106cb4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106d82be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:57:33 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 04:57:33 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 04:57:33 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 04:57:33 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:57:33 INFO - Return code: 0 04:57:33 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:57:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:57:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:57:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:57:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:57:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GzGlSoTBTU6Kp7CTkxdOlA/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0312', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:57:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GzGlSoTBTU6Kp7CTkxdOlA/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0312 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:57:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HTUOfOR6OQ/Render', 04:57:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:57:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:57:33 INFO - 'HOME': '/Users/cltbld', 04:57:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:57:33 INFO - 'LOGNAME': 'cltbld', 04:57:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:57:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:57:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:33 INFO - 'MOZ_NO_REMOTE': '1', 04:57:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:57:33 INFO - 'NO_EM_RESTART': '1', 04:57:33 INFO - 'PAGER': '/bin/cat', 04:57:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:57:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:33 INFO - 'PWD': '/builds/slave/test', 04:57:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:57:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:57:33 INFO - 'SHELL': '/bin/bash', 04:57:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vEcROtkoL7/Listeners', 04:57:33 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 04:57:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:57:33 INFO - 'USER': 'cltbld', 04:57:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:57:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:57:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:33 INFO - 'XPC_FLAGS': '0x0', 04:57:33 INFO - 'XPC_SERVICE_NAME': '0', 04:57:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:57:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GzGlSoTBTU6Kp7CTkxdOlA/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0312', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:57:33 INFO - mozversion application_buildid: 20170126030209 04:57:33 INFO - mozversion application_changeset: fbdfcecf0c774d2221f11aed5a504d5591c774e0 04:57:33 INFO - mozversion application_display_name: Nightly 04:57:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:57:33 INFO - mozversion application_name: Firefox 04:57:33 INFO - mozversion application_remotingname: firefox 04:57:33 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:57:33 INFO - mozversion application_vendor: Mozilla 04:57:33 INFO - mozversion application_version: 54.0a1 04:57:33 INFO - mozversion platform_buildid: 20170126030209 04:57:33 INFO - mozversion platform_changeset: fbdfcecf0c774d2221f11aed5a504d5591c774e0 04:57:33 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:57:33 INFO - mozversion platform_version: 54.0a1 04:57:33 INFO - using testdate: 1485435453 04:57:33 INFO - actual date: 1485435453 04:57:33 INFO - starting webserver on 'localhost:49366' 04:57:33 INFO - SUITE-START | Running 2 tests 04:57:33 INFO - TEST-START | dromaeo_css 04:57:33 INFO - operating with platform_type : mac_ 04:57:33 INFO - Initialising browser for dromaeo_css test... 04:57:33 INFO - TEST-INFO | started process 1911 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/tmphcpdUd/profile http://localhost:49366/getInfo.html) 04:57:36 INFO - PROCESS | 1911 | 2017-01-26 04:57:36.618 plugin-container[1914:16493] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9243, name = 'com.apple.tsm.portname' 04:57:36 INFO - PROCESS | 1911 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:57:36 INFO - PROCESS | 1911 | 2017-01-26 04:57:36.619 plugin-container[1914:16493] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4f07, name = 'com.apple.CFPasteboardClient' 04:57:36 INFO - PROCESS | 1911 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:57:36 INFO - PROCESS | 1911 | 2017-01-26 04:57:36.619 plugin-container[1914:16493] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:57:36 INFO - PROCESS | 1911 | __metrics Screen width/height:1600/1200 04:57:36 INFO - PROCESS | 1911 | colorDepth:24 04:57:36 INFO - PROCESS | 1911 | Browser inner width/height: 1024/689 04:57:36 INFO - PROCESS | 1911 | __metrics 04:57:36 ERROR - PROCESS | 1911 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3279: TypeError: this.tabs is undefined 04:57:37 INFO - TEST-INFO | 1911: exit 0 04:57:37 INFO - Browser initialized. 04:57:37 INFO - Running cycle 1/1 for dromaeo_css test... 04:57:37 INFO - TEST-INFO | started process 1915 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/tmphcpdUd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:57:40 INFO - PROCESS | 1915 | 2017-01-26 04:57:39.994 plugin-container[1916:16614] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x473f, name = 'com.apple.tsm.portname' 04:57:40 INFO - PROCESS | 1915 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:57:40 INFO - PROCESS | 1915 | 2017-01-26 04:57:39.995 plugin-container[1916:16614] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9003, name = 'com.apple.CFPasteboardClient' 04:57:40 INFO - PROCESS | 1915 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:57:40 INFO - PROCESS | 1915 | 2017-01-26 04:57:39.995 plugin-container[1916:16614] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:57:49 INFO - PROCESS | 1915 | RSS: Main: 233177088 04:57:49 INFO - PROCESS | 1915 | 05:00:52 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:49366/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49366/tests/dromaeo/cssquery-ext.html) 05:00:54 INFO - PROCESS | 1915 | RSS: Main: 264499200 05:00:54 INFO - PROCESS | 1915 | 05:02:37 INFO - PROCESS | 1915 | ************************* 05:02:37 INFO - PROCESS | 1915 | A coding exception was thrown and uncaught in a Task. 05:02:37 INFO - PROCESS | 1915 | 05:02:37 ERROR - PROCESS | 1915 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:02:37 INFO - PROCESS | 1915 | Full stack: 05:02:37 INFO - PROCESS | 1915 | ************************* 05:03:56 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:49366/tests/dromaeo/cssquery-ext.html (next: http://localhost:49366/tests/dromaeo/cssquery-jquery.html) 05:03:57 INFO - PROCESS | 1915 | RSS: Main: 267689984 05:03:57 INFO - PROCESS | 1915 | 05:06:59 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:49366/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49366/tests/dromaeo/cssquery-mootools.html) 05:06:59 INFO - PROCESS | 1915 | RSS: Main: 278417408 05:06:59 INFO - PROCESS | 1915 | 05:10:01 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:49366/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49366/tests/dromaeo/cssquery-prototype.html) 05:10:02 INFO - PROCESS | 1915 | RSS: Main: 275546112 05:10:02 INFO - PROCESS | 1915 | 05:13:05 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:49366/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49366/tests/dromaeo/cssquery-yui.html) 05:13:05 INFO - PROCESS | 1915 | RSS: Main: 280666112 05:13:05 INFO - PROCESS | 1915 | 05:16:08 INFO - PROCESS | 1915 | Cycle 1(1): loaded http://localhost:49366/tests/dromaeo/cssquery-yui.html (next: http://localhost:49366/tests/dromaeo/cssquery-dojo.html) 05:16:08 INFO - PROCESS | 1915 | RSS: Main: 283103232 05:16:08 INFO - PROCESS | 1915 | 05:16:08 INFO - PROCESS | 1915 | __start_tp_report 05:16:08 INFO - PROCESS | 1915 | _x_x_mozilla_page_load 05:16:08 INFO - PROCESS | 1915 | _x_x_mozilla_page_load_details 05:16:08 INFO - PROCESS | 1915 | |i|pagename|runs| 05:16:08 INFO - PROCESS | 1915 | |0;dojo.html;2972.197506673197;3087.4596945534527;3219.983900080499;3310.354480876227;3360.966390336096;5494.7527361268685;5509.752061157247;5518.530924871386;5565.053940830058;5575.135853942636;5409.486098820616;5491.533219676322;5525.281713377255;5547.805826796063;5570.693611851347;5016.949830501703;5091.84724458265;5098.413682426512;5124.385073791151;5137.332146820927;5068.645194836345;5165;5174.741262936857;5179.482051794828;5200.531952124308;5168.5606723428555;5170.198619214009;5174.974125129388;5191.948080519203;5196.246544251081;5171;5173.887614162954;5175.844724658266;5176;5194.220866869962;5037.546620804109;5132.820351287687;5141.203113517411;5144.3312369392115;5161.948380516184;5578.776848926038;5588.469095435927;5611.523020543259;5616.5787565932305;5646.011947909099;5879.911801322984;6036.15493830864;6111.480524155452;6136.96931515344;6161.599496032788;6053.515718742534;6077.604955677867;6110.3765049759795;6136.733532366115;6250.499960003234;5686.545076393879;5703.030484817591;5712.857178570527;5725.112607545837;5742.770289188427;6313.40022697843;6325.5255855811;6357.96821015892;6365.981442969195;6380.744770209232;5798.739056742373;5840.678762668009;5857.531397488276;6056.848578785478;6061;6086.756529738849;6102.913431175913;6114.724837382329;6122.602030868068;6189.35011823761;6090.36051214625;6110.686202466491;6120.843333897677;6130.6628135452975;6134.926387882192;6095.878082438327;6114.296855861544;6116;6157.076438534166;6171.382861713882;4801.4958429365115;4836.12949669063;4843.24929635907;4849.660523763373;4885.975570122127;4370.912581748347;4380;4400.581944715247;4409;4416.1609294233995;5742.08126699726;5742.799002034909;5743.827685169368;5748.913766293509;5755.65466072037;6028.5478589106;6104.610739188311;6134.559047376611;6151.5386346024225;6234.875302493925;5691.8292451226525;5748.597598168171;5749.338826034976;5771;5826.271716035496;5267.920981185285;5315.202719592092;5361.892762144736;5400.83797486076;5406.783728650888;5340.851716880889;6235.750569977241;6257.217847769029;6280.937190628035;6300.550873299076;5349.251104845403;5987.9401205989125;6055.091736239599;6075.2405949256345;6202.596831205957;6250.4374606285655;6262.749490020348;6273.592216505913;6282.654454005074;6283.403076707706;5457.399686034612;5549.278593782944;6094.085887116968;6100.267967843887;6102.0541816018585;6021;6081.969590152021;6210.285817130907;6211.627302361872;6215.906761398673;4901.3383193268455;6009.489193418433;6039;6042.274927008787;6047.485963693135;4683.484816670096;5788.594798364243;5917.822465326047;5926.67403292823;5955.67243801595;5494.532964698045;5693.3168019837885;5814.651120932757;5852.502537284378;5865.296164460292;5844.590878638624;5937.198478205387;5951.821445356646;6014.609050411709;6047.818565443044;5679.432056794288;5704.857378565569;5708.686022268815;5726.914096288642;5753.827385178452 05:16:08 INFO - PROCESS | 1915 | |1;ext.html;452.03039480314726;453.2046258815778;454.5477250136115;459.21015852733285;489.53983255739604;40349.79825100874;42370.57629423705;42397.78801105998;43996;44251.77874110633;42714.786426067825;42860.571394286046;43005;43066.78466607662;43144.352834707504;9291.72124836256;9482.762930926747;9492.288078394113;9506.619735210617;10788.406637634927;10845.891541084568;11098;11113.611023614176;11123.27698699582;11132.276402033882;11099;11147.888521114806;11157.888421115807;11160.162987775908;11176.720581985433;11035.503402346914;11090.778184436347;11110.222284440133;11114.388708621023;11120.777584448346;10833.891661083446;10990.340579565252;11049.060829829394;11094.667159985212;11095.833562496488;36839;37022.259554809025;37054;37056.81471592652;37162.44256336157;3611.3138503684218;3771.264603402338;3978.124812541236;3995.960040399588;4116.855910043134;28210.461058504832;28934.42131157386;29016.12951611434;29026.12921612355;29318.41363172746;3145.5438961350706;3184.26761844777;3230.80615163091;3323.833808309575;3332.350191712617;426835;429177.85411072744;430628;431158;435534;50927.49072509302;55437;55560.72219638876;55601.721991389786;55784.16323755147;55177.72411137919;55382.446175538535;55400.72299638476;55631.721841390536;55787.72106139443;15392.230388480531;15565.22173891301;15583.298751556207;15630.843691562939;15632.843671563367;10758.892411075945;11014.724631884266;11782.528698852122;11986.76026479483;12137.5144994201;17711.822881771273;17753.757236993286;17848.732269015974;17971.281148753904;18019.819801801816;6682.863913134779;7443.776686699408;7543.7736867894055;7645.438778009429;7774.611269436506;825.3768404854417;838.6435764799936;842.6629348260744;844.6663567890648;857.1942374168262;29681.954067808525;29973.550396744067;30137.547936780968;30178.54732179019;30593.847030764704;1036.388530766851;1038.553422028535;1058.8411738239326;1067.514281002142;1081.389015206406;15563.61090972712;15615.687686246212;15642.687146257238;15713.371465141496;15961.361545538048;599166;599365;602361;604966;606830;59309.70345148247;60202.096968545506;60204;60230;60284;1399.2234309958071;1408.5140626483847;1434.3473719457622;1436.102435977493;1443.3937746146644;28731.425371492034;29189.270268243465;29819.403611927206;30047.09858704155;30389.848050759603;51412;51652.22521662103;51811;51874;51924.74037629788;403549;405947;406064;407281;407574;24323;25042.123525676514;26322.210333690018;26694.59958100669;26725.72388417844;42238;43215.78392108019;43303;43465.56534434615;43817;34875;35065.948021559394;35745.46381804223;36451.22600616016;36455.45316820303;35777.926662200174;36031.81984090063;36402;36735.448968266035;37000.62999369972;32432.35135297328;35198.64801351954;35754.821225893706;35760.92717218488;36719.63280367269;31409.8429507851;32503;32554.674453255164;32605.510917335785;32648.51027234546;21860.89069554642;21933.232336868132;22546.77453225447;22625.434364141027;22878.741669208353 05:16:08 INFO - PROCESS | 1915 | |2;jquery.html;345.0924069696698;363.8126364922065;397.4554859842015;408.82011914757487;423.908859595187;19751;20293.797062029375;20839.27062552809;21196.364109076712;21383.93080345982;11508.194426390157;12011.661225427055;12100.273983560992;12104.576339828107;21395;5031.798728050882;5327.413984461706;5336.199570064483;5336.466353364652;5356.625036247464;5056.620753443488;5230.189320655304;5241.68549887008;5291.417944026154;5297.8940421191555;4205.768682722449;5260.973695131538;5271.28837606922;5303.23103150043;5478.863028424282;4468.8882777930485;4576.542345765413;4876.634252431047;4903.730294833783;5080.339555857733;4480.8349829044355;4614.169449499089;5153.407358153785;5181.766820493087;5202.505761952609;13063.216207027608;13126.540571079966;23450.296491105295;24432.51134977308;25470.490590188278;2227.465408301996;2588.935276618081;2652.82756620819;2789.581562765581;2881.6109825173753;9436.103570160893;9881.357711748786;9999.40003599779;10277.691669249934;10467.633632822815;1586.0562965035786;1830.9359172429033;1849.3527265457117;1891.6311319292743;1893.3751861885544;122966.15550766746;124755.37622311921;125440;135962;140999;11742.941285293518;11887.16789824704;12001.399580125928;12067.758644827054;12188.634340969786;15547.922260388626;15606.29771660278;15621.14083725406;15632.2183890805;15647.765283520755;8531.786705332417;8684.39209255346;8707.782305442415;8745.606447709868;8826.382153249211;8333.250007499355;8347.666093356198;8353.832923341499;8447.619857106445;8508.404411691246;4776.164171270014;4803.735794531264;4824.903501929942;4843.75781210938;4888.853334399973;1825.2516468247954;2027.9087441065187;2037.7962203779502;2060.8248298894464;2061.4333106838912;905.3296667648178;944.6079876851168;994.7065615643257;999.9900001000043;1069.9572017119383;21022.789772102387;21356.932153392267;21382.57234855294;21483.78516214818;21492.78507214908;838.3460900497622;912.5665308978182;1018.3228153277987;1043.087298613713;1049.6483677967967;10572.682819515427;10783.78432431347;10803;10992.340459572451;11028.834567481494;716845;726138;728112;731525.6847431564;744258;93694;108429;136315;137740.31129844286;158931.41068589166;957.363353370015;1011.2163073617858;1037.7353774787382;1041.9944753313089;1057.0644979193469;16484.34062637481;18679.90660046691;19060.80939190646;19210.423687289403;19512.9024354883;53891;53900.46099539111;57004;60089;60943.390566093774;78937.60531197308;79457.60271198607;79744.80382794379;80080;81241;7742.380609551335;8256.917430825615;11514.596989105341;12205.633830985085;12551.811722824348;13159.671008224488;13420.731585368043;13426.261555614536;13708.725825483634;14000.439982400998;11272.943635281772;11632.88367116318;11673;12009.678935316933;12066.034717222778;11131.443427828739;11354.489047993025;11566;11782.351970641697;11835.940820295844;11348.262362946381;11647.825282620597;11755;12048.75902481928;12131.696707582028;12161.878381216075;12197.817032744339;12330.445129969352;12450.439730211981;12456.252624842538;7281.286543862562;7371.336579707852;7779.4554381192775;7814.843703126019;8241.299489543457 05:16:08 INFO - PROCESS | 1915 | |3;mootools.html;1264.6585421936077;1290.167841742077;1414.2928535732135;1444.9060811047282;1446.638340414896;7413.6293185340655;7657.3874090072795;7915.12933577306;8327.08402075772;8343.666253349875;7850.528968261894;8134.349252059836;8155.510669359843;8258.91741082589;8331.250187483125;2276.1350686739015;2316.5830150572892;2319.988400058006;2323.0243297814873;2327.4763178284834;1940.7282980382759;2000.30989308689;2278.5784629843447;2313.9537209255805;2323.53529294141;2042.346449136277;2201.9889900550475;2276.7950884420397;2284.9885750571307;2290.4960908600083;2235.10595761695;2258.796708296253;2261.061659411359;2261.0842608743487;2266.764613285763;2170.2621108823078;2253.763354847734;2291.598970180212;2307.3770082077745;2313.7339205991357;8235.094139644634;8249.670013199464;8330.333573314121;8351.08138104808;8369.079401265855;5009.749512524396;5178.300929374524;5185.662931909452;5189.740512974374;5191.221316802472;3336.2493438976035;3420.538227339302;3446.138465383654;3494.248736521635;3498.195415054526;1204.9277043377426;1206.5223883568588;1245.371087600765;1251.7496500699897;1262.059765474727;10495;10507.422091784949;10560.52477638508;10631.681049568526;10730.678079657622;4146.91706165875;4360.9127817444105;4413.867583972486;4428.800703968329;4434.401355816988;8425.662973481114;8501.14988501145;8507.191816777397;8508.617112229964;8518.361122915807;5032.974835125801;5039.496050395004;5053.166227572409;5055.570276526463;5059.974700126476;4577.336286238543;4641.976790116028;4717.858464246078;4718.245080787126;4719.244920812654;3094.3965926644537;3618.222082252328;3677.8598634423415;3696.5194524711615;3719.8512059517857;1044.9164066874785;1143.7998350288667;1150.5742875136252;1151.067635215478;1153.117864833403;771.4792515052317;864.6282098697494;865.948043117415;867.2195024477894;927.8097989912052;5376.086065368897;5705.286839145107;5735.1074145531875;5736.856578585569;5846.093855452412;946.8485042393185;975.5658731864253;986.161762501882;998.3610489286717;1009.2279406254221;3215.437298472758;3446.500257462704;3717.8141092945243;3827.655511004023;3871.1483473635753;9447.90552094484;9721.9027809721;9788.853167202498;9796.510174491246;9803.460809655395;9719.514024298756;9732.90267097334;9739.610415583298;9748.268879833899;9752.951235243778;7153.891146872244;7573.583452910033;7574.545527268381;7607;7706.537607743553;5311.867203319948;5326.25432439451;5424;5605.103183490622;5651.519620832111;8859.64561417536;9067.04795996411;9113.270938325051;9137.949135849462;9142.862857057282;8671.696490622799;8998.14517620825;9106.408083474553;9183.77040573991;9283.907160928575;7014.86046755724;7153.713851445884;7157.785266442015;7164.176119746296;7170.89243661356;7664.885026724715;7674;7728.497647652885;7738.071431428265;7743.341815945708;6021.217241758543;6240.344763799917;6762.42519385838;6999.790006299819;7095.042169307284;6681.231658359351;6685.231198412245;6881.174259088942;6883.621400823003;6917.688704008432;6092.817215483543;6250.843728906813;6326.367363263636;6340.714667839866;6427.357264273535;4921.803127874845;4962;4973.950260497349;5002.499750024968;5052.166392545336;4847.151748443937;4910.803567857246;4920.8769780755765;4967.4535801062575;5117.232415137759 05:16:08 INFO - PROCESS | 1915 | |4;prototype.html;344.5933798118221;357.3353562373984;374.8613013185122;377.57522786864774;381.03027794263596;4405.427294451717;5378.919316210255;5491.28613280274;5518.19986102015;5518.847649416731;4848.369711937452;5071.301114126772;5077.771500282487;5261.97391508655;5475.233467314569;3473.6700013498803;3534.6111927687934;4237.7669228192435;4240.512341080785;4245.9575404246025;3480.443129099345;4144.259411047367;4157.9605098725315;4168.6039826216465;4201.264778663737;4042.2521833460755;4231;4242.4272723182285;4244.533101358864;4274.670304683939;3961.564227934925;4197.412362269285;4236.957630423687;4244.533101358848;4258.808353624064;2820.2667306500457;3253.6908993645566;3523.489094081344;3689.24370504046;3703.2408356286896;4393.384926110347;4792.688475249098;5147.327118686442;5175.404828444702;5312.3890752563175;4152.937705934383;4489.236829738952;4712.9969762851;4719.504452032522;4735.171345014609;5517.641353312022;5697.173909783059;5746.569007324468;5747.62640428375;5754.597178197528;3627.873024444158;3897.4020651532737;3910.374340105598;3915.7454765440157;3919.039835240356;5769.365369809318;5875.768327419902;5952.672603006833;6044.969775151096;6059.7273122709585;3377.932441351159;3585.296983932611;3710.888673339804;3754.1553150541454;3928.2929072767174;3550.786952782841;3692.929050575303;3749.962500374961;3974.8608798691907;3982.4623675803396;4552.385427967249;4563.780665189357;4638.758203230395;4662.696924699883;4673.182193116191;4762.238041913277;5377.892442151135;5496.6701997880255;5730.627509211888;5812.680302583399;1134.4384529657707;1246.0654509118162;1258.0187453786061;1293.8512071111754;1312.287464858369;818.9303909167668;830.3481766813023;852.4714676900361;880.6037283222576;882.179572997106;4566.105066397407;5198.792048318101;5237.895242095213;5259.948010397859;5266.631335806457;5007.69953802773;5253.605979551549;5693.526948561374;5714.856728871535;5719.027765279912;4700.600448961876;4823.541763532458;5140.457862641193;5218.869528261824;5243.4232234454175;2692.488427198826;2823.8729257183477;2924.7952643314766;2943.8518977598756;2964.0515035188964;5080.54275115234;5447.4824891635235;5501.889962200734;5772.556860784804;5855.696063393402;5238.135707608279;5257.027449921777;5479.945200548023;5835.270591176103;5860.853478663067;4864.708117512961;5716.771329146871;5763.740631671585;5795.449432303924;5903.26209223847;5216.843494695166;5705.030144875298;5708.200851880823;5721.141828725558;5740.368559458373;4859.416869975626;5572.91640625399;5588.217649528988;5603.35561410443;5612.494875461228;5725.76895967369;5799.072148456226;5940.257467816523;5974.761009559569;6159.4456498915315;3483.5993860706344;3863.879474952232;3908.550516690503;3917.5494818096286;3937.4684417603257;4987.2819313474965;5535.833924982257;5684.550439637866;5882.588218824641;5937.643741375531;5425.511703946664;5498.230247765236;5581.469760372758;5705.834740639273;5845.035569131216;5425.891482170414;5773.884522309614;5802.332731735904;5806.65160090396;5820.526276332626;4594.4838203393465;5301.602379821452;5569.944300556943;5659.292588426447;5675.545956323567;4633.4208223972;5114.590832733298;5410.269613602113;5700.463293834204;5797.782465682254;5349.786008559614;5362.892742145214;5606.486248712743;5671.319441666861;5671.489565939085 05:16:08 INFO - PROCESS | 1915 | |5;yui.html;703.1175874277781;716;731.4623751542615;823.1850468036644;828.1594181905364;14749.336279867404;15576.376944922218;15625.140617266074;15673.451429199995;15710.92144539277;13565.118267312619;13675.521356752515;13720.862791372108;13736.107153035045;13737.725245495085;666.1839246922506;690.5511417578564;839.5004972041626;858.2704701004143;873.7116751471999;792.9770595931242;856.8457677618027;867.2151702709058;867.6702852915884;870.5386145342978;872.075599864146;926.0970553710146;932.3799673217336;932.8507438809792;933.6732143749701;908.123660667459;916.3722849847876;923.8937522184967;924.9815003699888;925.0841666749936;687.3744892148121;689.1316940654812;689.1902015132199;690.3200347657553;691.5470366909682;14762.70474590502;14828.777568336483;14880.181590012546;15041.699166016619;15910;14174.43302267908;14395.928020359832;14498.275086245645;14643;14649.414023439049;11670;11711.297322160697;11715.289140759083;11985.940070299679;12299.740568749288;3709.4806727058235;3731.477593136963;3745.606711295302;3767.190054138346;3888.6694630956404;97500.53749193768;98433.50783246038;101232;101293;101558;11030.117590592734;11068;11183.888161118448;11238.133108007389;11351.091912646969;22717.318480445614;22831;22890;23025.88487057554;23025.884870575876;7509.699612015567;7723.218272197728;7726;7753.263439973193;7789.221077892165;4199.2441360554785;4299.376590394438;4328.394024836525;4331.523532411432;4337.587929146726;3442;3515.789052656849;3521.0669172669263;3537.080359106599;3552.431610942237;632.8164832198611;645.2418408370146;654.5876098058288;660.389140045456;664.3489380407228;535.8044313825426;568.3009897825615;604.3050491934223;608.3394018656356;629.8382121748796;9461.195798357217;10185.541650625739;10192.827824800243;10294.433806140734;10362.740931476774;552.7402121003122;651.4430162211336;659.3768888400416;691.7336825322186;696.8362434827811;4871.098846713369;4956.975215123974;4966.503349665005;4973.676711013773;4986.601071914238;101981;104006;105081.94918050722;105853;107953.46023269833;92241;92986;93263.66840829034;94166;95366.52316738373;79360.20639793643;79361;80274.19725802784;80519.59740201262;80593;9527.47598882068;9598.568064436977;9601.807963840545;9625.133737963617;9714.465704386326;53046.204306934655;53597;54022.72988635032;54115.72942135264;54643.18035229395;69617.69014253633;70887.64556177186;71982;72113.27886721065;72117.27882721106;10906.781864362827;11435.428228588704;11507.712307192387;11517.193796434169;11674;12389.442475088823;12588.559400420942;15058.472953446577;15124.848751512343;15539.300731467338;12011.879881201075;13050.282234476816;13594.184348939096;13615.978801589723;14215.431382744988;11384.772304554028;13103.934480327538;13521.391537380645;13689.657758556115;14054.929725351309;11212.49543770516;13200.405981731037;13620.455181792617;13743.450261989408;13884.72230555363;10958.397288149228;11104.278221915549;11252;11322.150838686966;11607.883921160681;8956.776080598038;10688.448307712415;10839.078678312117;10857.619983300547;10890.346579205274 05:16:08 INFO - PROCESS | 1915 | __end_tp_report 05:16:08 INFO - PROCESS | 1915 | __start_cc_report 05:16:08 INFO - PROCESS | 1915 | _x_x_mozilla_cycle_collect,409 05:16:08 INFO - PROCESS | 1915 | __end_cc_report 05:16:08 INFO - PROCESS | 1915 | __startTimestamp1485436568601__endTimestamp 05:16:08 INFO - PROCESS | 1915 | 05:16:08 INFO - PROCESS | 1915 | ------- Summary: start ------- 05:16:08 INFO - PROCESS | 1915 | Number of tests: 6 05:16:08 INFO - PROCESS | 1915 | 05:16:08 INFO - PROCESS | 1915 | [#0] dojo.html Cycles:165 Average:5621.91 Median:5748.91 stddev:641.09 (11.2%) stddev-sans-first:608.43 05:16:08 INFO - PROCESS | 1915 | Values: 2972.2 3087.5 3220.0 3310.4 3361.0 5494.8 5509.8 5518.5 5565.1 5575.1 5409.5 5491.5 5525.3 5547.8 5570.7 5016.9 5091.8 5098.4 5124.4 5137.3 5068.6 5165.0 5174.7 5179.5 5200.5 5168.6 5170.2 5175.0 5191.9 5196.2 5171.0 5173.9 5175.8 5176.0 5194.2 5037.5 5132.8 5141.2 5144.3 5161.9 5578.8 5588.5 5611.5 5616.6 5646.0 5879.9 6036.2 6111.5 6137.0 6161.6 6053.5 6077.6 6110.4 6136.7 6250.5 5686.5 5703.0 5712.9 5725.1 5742.8 6313.4 6325.5 6358.0 6366.0 6380.7 5798.7 5840.7 5857.5 6056.8 6061.0 6086.8 6102.9 6114.7 6122.6 6189.4 6090.4 6110.7 6120.8 6130.7 6134.9 6095.9 6114.3 6116.0 6157.1 6171.4 4801.5 4836.1 4843.2 4849.7 4886.0 4370.9 4380.0 4400.6 4409.0 4416.2 5742.1 5742.8 5743.8 5748.9 5755.7 6028.5 6104.6 6134.6 6151.5 6234.9 5691.8 5748.6 5749.3 5771.0 5826.3 5267.9 5315.2 5361.9 5400.8 5406.8 5340.9 6235.8 6257.2 6280.9 6300.6 5349.3 5987.9 6055.1 6075.2 6202.6 6250.4 6262.7 6273.6 6282.7 6283.4 5457.4 5549.3 6094.1 6100.3 6102.1 6021.0 6082.0 6210.3 6211.6 6215.9 4901.3 6009.5 6039.0 6042.3 6047.5 4683.5 5788.6 5917.8 5926.7 5955.7 5494.5 5693.3 5814.7 5852.5 5865.3 5844.6 5937.2 5951.8 6014.6 6047.8 5679.4 5704.9 5708.7 5726.9 5753.8 05:16:08 INFO - PROCESS | 1915 | 05:16:08 INFO - PROCESS | 1915 | [#1] ext.html Cycles:180 Average:62126.85 Median:35750.14 stddev:129894.91 (363.3%) stddev-sans-first:130176.76 05:16:08 INFO - PROCESS | 1915 | Values: 452.0 453.2 454.5 459.2 489.5 40349.8 42370.6 42397.8 43996.0 44251.8 42714.8 42860.6 43005.0 43066.8 43144.4 9291.7 9482.8 9492.3 9506.6 10788.4 10845.9 11098.0 11113.6 11123.3 11132.3 11099.0 11147.9 11157.9 11160.2 11176.7 11035.5 11090.8 11110.2 11114.4 11120.8 10833.9 10990.3 11049.1 11094.7 11095.8 36839.0 37022.3 37054.0 37056.8 37162.4 3611.3 3771.3 3978.1 3996.0 4116.9 28210.5 28934.4 29016.1 29026.1 29318.4 3145.5 3184.3 3230.8 3323.8 3332.4 426835.0 429177.9 430628.0 431158.0 435534.0 50927.5 55437.0 55560.7 55601.7 55784.2 55177.7 55382.4 55400.7 55631.7 55787.7 15392.2 15565.2 15583.3 15630.8 15632.8 10758.9 11014.7 11782.5 11986.8 12137.5 17711.8 17753.8 17848.7 17971.3 18019.8 6682.9 7443.8 7543.8 7645.4 7774.6 825.4 838.6 842.7 844.7 857.2 29682.0 29973.6 30137.5 30178.5 30593.8 1036.4 1038.6 1058.8 1067.5 1081.4 15563.6 15615.7 15642.7 15713.4 15961.4 599166.0 599365.0 602361.0 604966.0 606830.0 59309.7 60202.1 60204.0 60230.0 60284.0 1399.2 1408.5 1434.3 1436.1 1443.4 28731.4 29189.3 29819.4 30047.1 30389.8 51412.0 51652.2 51811.0 51874.0 51924.7 403549.0 405947.0 406064.0 407281.0 407574.0 24323.0 25042.1 26322.2 26694.6 26725.7 42238.0 43215.8 43303.0 43465.6 43817.0 34875.0 35065.9 35745.5 36451.2 36455.5 35777.9 36031.8 36402.0 36735.4 37000.6 32432.4 35198.6 35754.8 35760.9 36719.6 31409.8 32503.0 32554.7 32605.5 32648.5 21860.9 21933.2 22546.8 22625.4 22878.7 05:16:08 INFO - PROCESS | 1915 | 05:16:08 INFO - PROCESS | 1915 | [#2] jquery.html Cycles:180 Average:38955.25 Median:21389.47 stddev:121032.28 (565.8%) stddev-sans-first:121337.08 05:16:08 INFO - PROCESS | 1915 | Values: 345.1 363.8 397.5 408.8 423.9 19751.0 20293.8 20839.3 21196.4 21383.9 11508.2 12011.7 12100.3 12104.6 21395.0 5031.8 5327.4 5336.2 5336.5 5356.6 5056.6 5230.2 5241.7 5291.4 5297.9 4205.8 5261.0 5271.3 5303.2 5478.9 4468.9 4576.5 4876.6 4903.7 5080.3 4480.8 4614.2 5153.4 5181.8 5202.5 13063.2 13126.5 23450.3 24432.5 25470.5 2227.5 2588.9 2652.8 2789.6 2881.6 9436.1 9881.4 9999.4 10277.7 10467.6 1586.1 1830.9 1849.4 1891.6 1893.4 122966.2 124755.4 125440.0 135962.0 140999.0 11742.9 11887.2 12001.4 12067.8 12188.6 15547.9 15606.3 15621.1 15632.2 15647.8 8531.8 8684.4 8707.8 8745.6 8826.4 8333.3 8347.7 8353.8 8447.6 8508.4 4776.2 4803.7 4824.9 4843.8 4888.9 1825.3 2027.9 2037.8 2060.8 2061.4 905.3 944.6 994.7 1000.0 1070.0 21022.8 21356.9 21382.6 21483.8 21492.8 838.3 912.6 1018.3 1043.1 1049.6 10572.7 10783.8 10803.0 10992.3 11028.8 716845.0 726138.0 728112.0 731525.7 744258.0 93694.0 108429.0 136315.0 137740.3 158931.4 957.4 1011.2 1037.7 1042.0 1057.1 16484.3 18679.9 19060.8 19210.4 19512.9 53891.0 53900.5 57004.0 60089.0 60943.4 78937.6 79457.6 79744.8 80080.0 81241.0 7742.4 8256.9 11514.6 12205.6 12551.8 13159.7 13420.7 13426.3 13708.7 14000.4 11272.9 11632.9 11673.0 12009.7 12066.0 11131.4 11354.5 11566.0 11782.4 11835.9 11348.3 11647.8 11755.0 12048.8 12131.7 12161.9 12197.8 12330.4 12450.4 12456.3 7281.3 7371.3 7779.5 7814.8 8241.3 05:16:08 INFO - PROCESS | 1915 | 05:16:08 INFO - PROCESS | 1915 | [#3] mootools.html Cycles:180 Average:5301.18 Median:5251.54 stddev:2870.01 (54.7%) stddev-sans-first:2862.02 05:16:08 INFO - PROCESS | 1915 | Values: 1264.7 1290.2 1414.3 1444.9 1446.6 7413.6 7657.4 7915.1 8327.1 8343.7 7850.5 8134.3 8155.5 8258.9 8331.3 2276.1 2316.6 2320.0 2323.0 2327.5 1940.7 2000.3 2278.6 2314.0 2323.5 2042.3 2202.0 2276.8 2285.0 2290.5 2235.1 2258.8 2261.1 2261.1 2266.8 2170.3 2253.8 2291.6 2307.4 2313.7 8235.1 8249.7 8330.3 8351.1 8369.1 5009.7 5178.3 5185.7 5189.7 5191.2 3336.2 3420.5 3446.1 3494.2 3498.2 1204.9 1206.5 1245.4 1251.7 1262.1 10495.0 10507.4 10560.5 10631.7 10730.7 4146.9 4360.9 4413.9 4428.8 4434.4 8425.7 8501.1 8507.2 8508.6 8518.4 5033.0 5039.5 5053.2 5055.6 5060.0 4577.3 4642.0 4717.9 4718.2 4719.2 3094.4 3618.2 3677.9 3696.5 3719.9 1044.9 1143.8 1150.6 1151.1 1153.1 771.5 864.6 865.9 867.2 927.8 5376.1 5705.3 5735.1 5736.9 5846.1 946.8 975.6 986.2 998.4 1009.2 3215.4 3446.5 3717.8 3827.7 3871.1 9447.9 9721.9 9788.9 9796.5 9803.5 9719.5 9732.9 9739.6 9748.3 9753.0 7153.9 7573.6 7574.5 7607.0 7706.5 5311.9 5326.3 5424.0 5605.1 5651.5 8859.6 9067.0 9113.3 9137.9 9142.9 8671.7 8998.1 9106.4 9183.8 9283.9 7014.9 7153.7 7157.8 7164.2 7170.9 7664.9 7674.0 7728.5 7738.1 7743.3 6021.2 6240.3 6762.4 6999.8 7095.0 6681.2 6685.2 6881.2 6883.6 6917.7 6092.8 6250.8 6326.4 6340.7 6427.4 4921.8 4962.0 4974.0 5002.5 5052.2 4847.2 4910.8 4920.9 4967.5 5117.2 05:16:08 INFO - PROCESS | 1915 | 05:16:08 INFO - PROCESS | 1915 | [#4] prototype.html Cycles:180 Average:4563.81 Median:5187.10 stddev:1406.59 (27.1%) stddev-sans-first:1374.42 05:16:08 INFO - PROCESS | 1915 | Values: 344.6 357.3 374.9 377.6 381.0 4405.4 5378.9 5491.3 5518.2 5518.8 4848.4 5071.3 5077.8 5262.0 5475.2 3473.7 3534.6 4237.8 4240.5 4246.0 3480.4 4144.3 4158.0 4168.6 4201.3 4042.3 4231.0 4242.4 4244.5 4274.7 3961.6 4197.4 4237.0 4244.5 4258.8 2820.3 3253.7 3523.5 3689.2 3703.2 4393.4 4792.7 5147.3 5175.4 5312.4 4152.9 4489.2 4713.0 4719.5 4735.2 5517.6 5697.2 5746.6 5747.6 5754.6 3627.9 3897.4 3910.4 3915.7 3919.0 5769.4 5875.8 5952.7 6045.0 6059.7 3377.9 3585.3 3710.9 3754.2 3928.3 3550.8 3692.9 3750.0 3974.9 3982.5 4552.4 4563.8 4638.8 4662.7 4673.2 4762.2 5377.9 5496.7 5730.6 5812.7 1134.4 1246.1 1258.0 1293.9 1312.3 818.9 830.3 852.5 880.6 882.2 4566.1 5198.8 5237.9 5259.9 5266.6 5007.7 5253.6 5693.5 5714.9 5719.0 4700.6 4823.5 5140.5 5218.9 5243.4 2692.5 2823.9 2924.8 2943.9 2964.1 5080.5 5447.5 5501.9 5772.6 5855.7 5238.1 5257.0 5479.9 5835.3 5860.9 4864.7 5716.8 5763.7 5795.4 5903.3 5216.8 5705.0 5708.2 5721.1 5740.4 4859.4 5572.9 5588.2 5603.4 5612.5 5725.8 5799.1 5940.3 5974.8 6159.4 3483.6 3863.9 3908.6 3917.5 3937.5 4987.3 5535.8 5684.6 5882.6 5937.6 5425.5 5498.2 5581.5 5705.8 5845.0 5425.9 5773.9 5802.3 5806.7 5820.5 4594.5 5301.6 5569.9 5659.3 5675.5 4633.4 5114.6 5410.3 5700.5 5797.8 5349.8 5362.9 5606.5 5671.3 5671.5 05:16:08 INFO - PROCESS | 1915 | 05:16:08 INFO - PROCESS | 1915 | [#5] yui.html Cycles:180 Average:20724.44 Median:4043.96 stddev:29804.96 (737.0%) stddev-sans-first:29850.66 05:16:08 INFO - PROCESS | 1915 | Values: 703.1 716.0 731.5 823.2 828.2 14749.3 15576.4 15625.1 15673.5 15710.9 13565.1 13675.5 13720.9 13736.1 13737.7 666.2 690.6 839.5 858.3 873.7 793.0 856.8 867.2 867.7 870.5 872.1 926.1 932.4 932.9 933.7 908.1 916.4 923.9 925.0 925.1 687.4 689.1 689.2 690.3 691.5 14762.7 14828.8 14880.2 15041.7 15910.0 14174.4 14395.9 14498.3 14643.0 14649.4 11670.0 11711.3 11715.3 11985.9 12299.7 3709.5 3731.5 3745.6 3767.2 3888.7 97500.5 98433.5 101232.0 101293.0 101558.0 11030.1 11068.0 11183.9 11238.1 11351.1 22717.3 22831.0 22890.0 23025.9 23025.9 7509.7 7723.2 7726.0 7753.3 7789.2 4199.2 4299.4 4328.4 4331.5 4337.6 3442.0 3515.8 3521.1 3537.1 3552.4 632.8 645.2 654.6 660.4 664.3 535.8 568.3 604.3 608.3 629.8 9461.2 10185.5 10192.8 10294.4 10362.7 552.7 651.4 659.4 691.7 696.8 4871.1 4957.0 4966.5 4973.7 4986.6 101981.0 104006.0 105081.9 105853.0 107953.5 92241.0 92986.0 93263.7 94166.0 95366.5 79360.2 79361.0 80274.2 80519.6 80593.0 9527.5 9598.6 9601.8 9625.1 9714.5 53046.2 53597.0 54022.7 54115.7 54643.2 69617.7 70887.6 71982.0 72113.3 72117.3 10906.8 11435.4 11507.7 11517.2 11674.0 12389.4 12588.6 15058.5 15124.8 15539.3 12011.9 13050.3 13594.2 13616.0 14215.4 11384.8 13103.9 13521.4 13689.7 14054.9 11212.5 13200.4 13620.5 13743.5 13884.7 10958.4 11104.3 11252.0 11322.2 11607.9 8956.8 10688.4 10839.1 10857.6 10890.3 05:16:08 INFO - PROCESS | 1915 | -------- Summary: end -------- 05:16:08 INFO - PROCESS | 1915 | 05:16:09 INFO - TEST-INFO | 1915: exit 0 05:16:09 INFO - TEST-OK | dromaeo_css | took 1115933ms 05:16:09 INFO - TEST-START | kraken 05:16:09 INFO - operating with platform_type : mac_ 05:16:09 INFO - Initialising browser for kraken test... 05:16:09 INFO - TEST-INFO | started process 1921 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/tmp1mwfqK/profile http://localhost:49366/getInfo.html) 05:16:12 INFO - PROCESS | 1921 | 2017-01-26 05:16:12.382 plugin-container[1923:18653] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4647, name = 'com.apple.tsm.portname' 05:16:12 INFO - PROCESS | 1921 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:16:12 INFO - PROCESS | 1921 | 2017-01-26 05:16:12.383 plugin-container[1923:18653] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d0b, name = 'com.apple.CFPasteboardClient' 05:16:12 INFO - PROCESS | 1921 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:16:12 INFO - PROCESS | 1921 | 2017-01-26 05:16:12.383 plugin-container[1923:18653] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:16:12 INFO - PROCESS | 1921 | __metrics Screen width/height:1600/1200 05:16:12 INFO - PROCESS | 1921 | colorDepth:24 05:16:12 INFO - PROCESS | 1921 | Browser inner width/height: 1024/689 05:16:12 INFO - PROCESS | 1921 | __metrics 05:16:12 ERROR - PROCESS | 1921 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3279: TypeError: this.tabs is undefined 05:16:13 INFO - TEST-INFO | 1921: exit 0 05:16:13 INFO - Browser initialized. 05:16:13 INFO - Running cycle 1/1 for kraken test... 05:16:13 INFO - TEST-INFO | started process 1924 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/tmp1mwfqK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:16:16 INFO - PROCESS | 1924 | 2017-01-26 05:16:16.168 plugin-container[1925:18773] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x893f, name = 'com.apple.tsm.portname' 05:16:16 INFO - PROCESS | 1924 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:16:16 INFO - PROCESS | 1924 | 2017-01-26 05:16:16.169 plugin-container[1925:18773] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0b, name = 'com.apple.CFPasteboardClient' 05:16:16 INFO - PROCESS | 1924 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:16:16 INFO - PROCESS | 1924 | 2017-01-26 05:16:16.169 plugin-container[1925:18773] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:16:25 INFO - PROCESS | 1924 | RSS: Main: 234196992 05:16:25 INFO - PROCESS | 1924 | 05:16:28 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:49366/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49366/tests/kraken/driver.html?testName=audio-beat-detection) 05:16:29 INFO - PROCESS | 1924 | RSS: Main: 248107008 05:16:29 INFO - PROCESS | 1924 | 05:16:32 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:49366/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49366/tests/kraken/driver.html?testName=audio-dft) 05:16:32 INFO - PROCESS | 1924 | RSS: Main: 256393216 05:16:32 INFO - PROCESS | 1924 | 05:16:36 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:49366/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49366/tests/kraken/driver.html?testName=audio-fft) 05:16:36 INFO - PROCESS | 1924 | RSS: Main: 258338816 05:16:36 INFO - PROCESS | 1924 | 05:16:38 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:49366/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49366/tests/kraken/driver.html?testName=audio-oscillator) 05:16:39 INFO - PROCESS | 1924 | RSS: Main: 259792896 05:16:39 INFO - PROCESS | 1924 | 05:16:41 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:49366/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49366/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:16:41 INFO - PROCESS | 1924 | RSS: Main: 259633152 05:16:41 INFO - PROCESS | 1924 | 05:16:44 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:49366/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49366/tests/kraken/driver.html?testName=imaging-darkroom) 05:16:45 INFO - PROCESS | 1924 | RSS: Main: 266792960 05:16:45 INFO - PROCESS | 1924 | 05:16:48 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:49366/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49366/tests/kraken/driver.html?testName=imaging-desaturate) 05:16:49 INFO - PROCESS | 1924 | RSS: Main: 265531392 05:16:49 INFO - PROCESS | 1924 | 05:16:52 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:49366/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49366/tests/kraken/driver.html?testName=json-parse-financial) 05:16:53 INFO - PROCESS | 1924 | RSS: Main: 265879552 05:16:53 INFO - PROCESS | 1924 | 05:16:54 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:49366/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49366/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:16:55 INFO - PROCESS | 1924 | RSS: Main: 265158656 05:16:55 INFO - PROCESS | 1924 | 05:16:57 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:49366/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49366/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:16:58 INFO - PROCESS | 1924 | RSS: Main: 265199616 05:16:58 INFO - PROCESS | 1924 | 05:17:00 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:49366/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49366/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:17:00 INFO - PROCESS | 1924 | RSS: Main: 265228288 05:17:00 INFO - PROCESS | 1924 | 05:17:03 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:49366/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49366/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:17:04 INFO - PROCESS | 1924 | RSS: Main: 266166272 05:17:04 INFO - PROCESS | 1924 | 05:17:07 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:49366/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49366/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:17:08 INFO - PROCESS | 1924 | RSS: Main: 265654272 05:17:08 INFO - PROCESS | 1924 | 05:17:10 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:49366/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49366/tests/kraken/driver.html?testName=ai-astar) 05:17:10 INFO - PROCESS | 1924 | RSS: Main: 267485184 05:17:10 INFO - PROCESS | 1924 | 05:17:10 INFO - PROCESS | 1924 | __start_tp_report 05:17:10 INFO - PROCESS | 1924 | _x_x_mozilla_page_load 05:17:10 INFO - PROCESS | 1924 | _x_x_mozilla_page_load_details 05:17:10 INFO - PROCESS | 1924 | |i|pagename|runs| 05:17:10 INFO - PROCESS | 1924 | |0;ai-astar;106;120;117;117;118;117;119;119;118;119 05:17:10 INFO - PROCESS | 1924 | |1;audio-beat-detection;149;112;111;150;111;115;114;111;135;113 05:17:10 INFO - PROCESS | 1924 | |2;audio-dft;198;209;222;206;198;196;196;193;220;261 05:17:10 INFO - PROCESS | 1924 | |3;audio-fft;101;82;82;109;65;59;60;60;73;61 05:17:10 INFO - PROCESS | 1924 | |4;audio-oscillator;84;71;85;73;70;72;82;72;72;80 05:17:10 INFO - PROCESS | 1924 | |5;imaging-gaussian-blur;92;88;89;87;98;113;116;89;77;127 05:17:10 INFO - PROCESS | 1924 | |6;imaging-darkroom;147;93;140;153;107;155;114;96;98;118 05:17:10 INFO - PROCESS | 1924 | |7;imaging-desaturate;91;93;93;91;105;146;123;91;126;146 05:17:10 INFO - PROCESS | 1924 | |8;json-parse-financial;61;60;61;60;63;62;62;62;61;61 05:17:10 INFO - PROCESS | 1924 | |9;json-stringify-tinderbox;73;77;103;122;80;73;71;71;73;73 05:17:10 INFO - PROCESS | 1924 | |10;stanford-crypto-aes;87;89;92;88;91;88;87;89;90;89 05:17:10 INFO - PROCESS | 1924 | |11;stanford-crypto-ccm;147;145;145;152;149;159;157;155;206;161 05:17:10 INFO - PROCESS | 1924 | |12;stanford-crypto-pbkdf2;176;180;174;174;200;210;175;173;176;159 05:17:10 INFO - PROCESS | 1924 | |13;stanford-crypto-sha256-iterative;66;69;85;87;88;73;63;85;90;88 05:17:10 INFO - PROCESS | 1924 | __end_tp_report 05:17:10 INFO - PROCESS | 1924 | __start_cc_report 05:17:10 INFO - PROCESS | 1924 | _x_x_mozilla_cycle_collect,941 05:17:10 INFO - PROCESS | 1924 | __end_cc_report 05:17:10 INFO - PROCESS | 1924 | __startTimestamp1485436630387__endTimestamp 05:17:10 INFO - PROCESS | 1924 | 05:17:10 INFO - PROCESS | 1924 | ------- Summary: start ------- 05:17:10 INFO - PROCESS | 1924 | Number of tests: 14 05:17:10 INFO - PROCESS | 1924 | 05:17:10 INFO - PROCESS | 1924 | [#0] ai-astar Cycles:10 Average:117.00 Median:118.50 stddev:4.00 (3.4%) stddev-sans-first:1.09 05:17:10 INFO - PROCESS | 1924 | Values: 106.0 120.0 117.0 117.0 118.0 117.0 119.0 119.0 118.0 119.0 05:17:10 INFO - PROCESS | 1924 | 05:17:10 INFO - PROCESS | 1924 | [#1] audio-beat-detection Cycles:10 Average:122.10 Median:114.50 stddev:16.12 (14.1%) stddev-sans-first:13.85 05:17:10 INFO - PROCESS | 1924 | Values: 149.0 112.0 111.0 150.0 111.0 115.0 114.0 111.0 135.0 113.0 05:17:10 INFO - PROCESS | 1924 | 05:17:10 INFO - PROCESS | 1924 | [#2] audio-dft Cycles:10 Average:209.90 Median:207.50 stddev:20.63 (9.9%) stddev-sans-first:21.43 05:17:10 INFO - PROCESS | 1924 | Values: 198.0 209.0 222.0 206.0 198.0 196.0 196.0 193.0 220.0 261.0 05:17:10 INFO - PROCESS | 1924 | 05:17:10 INFO - PROCESS | 1924 | [#3] audio-fft Cycles:10 Average:75.20 Median:63.00 stddev:18.06 (28.7%) stddev-sans-first:16.57 05:17:10 INFO - PROCESS | 1924 | Values: 101.0 82.0 82.0 109.0 65.0 59.0 60.0 60.0 73.0 61.0 05:17:10 INFO - PROCESS | 1924 | 05:17:10 INFO - PROCESS | 1924 | [#4] audio-oscillator Cycles:10 Average:76.10 Median:76.50 stddev:5.92 (7.7%) stddev-sans-first:5.54 05:17:10 INFO - PROCESS | 1924 | Values: 84.0 71.0 85.0 73.0 70.0 72.0 82.0 72.0 72.0 80.0 05:17:10 INFO - PROCESS | 1924 | 05:17:10 INFO - PROCESS | 1924 | [#5] imaging-gaussian-blur Cycles:10 Average:97.60 Median:88.50 stddev:15.81 (17.9%) stddev-sans-first:16.63 05:17:10 INFO - PROCESS | 1924 | Values: 92.0 88.0 89.0 87.0 98.0 113.0 116.0 89.0 77.0 127.0 05:17:10 INFO - PROCESS | 1924 | 05:17:10 INFO - PROCESS | 1924 | [#6] imaging-darkroom Cycles:10 Average:122.10 Median:154.00 stddev:24.49 (15.9%) stddev-sans-first:24.26 05:17:10 INFO - PROCESS | 1924 | Values: 147.0 93.0 140.0 153.0 107.0 155.0 114.0 96.0 98.0 118.0 05:17:10 INFO - PROCESS | 1924 | 05:17:10 INFO - PROCESS | 1924 | [#7] imaging-desaturate Cycles:10 Average:110.50 Median:91.00 stddev:22.85 (25.1%) stddev-sans-first:23.12 05:17:10 INFO - PROCESS | 1924 | Values: 91.0 93.0 93.0 91.0 105.0 146.0 123.0 91.0 126.0 146.0 05:17:10 INFO - PROCESS | 1924 | 05:17:10 INFO - PROCESS | 1924 | [#8] json-parse-financial Cycles:10 Average:61.30 Median:61.50 stddev:0.95 (1.5%) stddev-sans-first:1.00 05:17:10 INFO - PROCESS | 1924 | Values: 61.0 60.0 61.0 60.0 63.0 62.0 62.0 62.0 61.0 61.0 05:17:10 INFO - PROCESS | 1924 | 05:17:10 INFO - PROCESS | 1924 | [#9] json-stringify-tinderbox Cycles:10 Average:81.60 Median:73.00 stddev:17.11 (23.4%) stddev-sans-first:17.86 05:17:10 INFO - PROCESS | 1924 | Values: 73.0 77.0 103.0 122.0 80.0 73.0 71.0 71.0 73.0 73.0 05:17:10 INFO - PROCESS | 1924 | 05:17:10 INFO - PROCESS | 1924 | [#10] stanford-crypto-aes Cycles:10 Average:89.00 Median:89.00 stddev:1.63 (1.8%) stddev-sans-first:1.56 05:17:10 INFO - PROCESS | 1924 | Values: 87.0 89.0 92.0 88.0 91.0 88.0 87.0 89.0 90.0 89.0 05:17:10 INFO - PROCESS | 1924 | 05:17:10 INFO - PROCESS | 1924 | [#11] stanford-crypto-ccm Cycles:10 Average:157.60 Median:156.00 stddev:17.95 (11.5%) stddev-sans-first:18.62 05:17:10 INFO - PROCESS | 1924 | Values: 147.0 145.0 145.0 152.0 149.0 159.0 157.0 155.0 206.0 161.0 05:17:10 INFO - PROCESS | 1924 | 05:17:10 INFO - PROCESS | 1924 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.70 Median:176.00 stddev:14.60 (8.3%) stddev-sans-first:15.42 05:17:10 INFO - PROCESS | 1924 | Values: 176.0 180.0 174.0 174.0 200.0 210.0 175.0 173.0 176.0 159.0 05:17:10 INFO - PROCESS | 1924 | 05:17:10 INFO - PROCESS | 1924 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:79.40 Median:86.00 stddev:10.43 (12.1%) stddev-sans-first:9.87 05:17:10 INFO - PROCESS | 1924 | Values: 66.0 69.0 85.0 87.0 88.0 73.0 63.0 85.0 90.0 88.0 05:17:10 INFO - PROCESS | 1924 | -------- Summary: end -------- 05:17:10 INFO - PROCESS | 1924 | 05:17:11 INFO - TEST-INFO | 1924: exit 0 05:17:11 INFO - TEST-OK | kraken | took 62026ms 05:17:11 INFO - SUITE-END | took 1177s 05:17:11 INFO - Completed test suite (00:19:38) 05:17:11 INFO - javascript benchmark 05:17:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7196.382264503415, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2972.197506673197, 3087.4596945534527, 3219.983900080499, 3310.354480876227, 3360.966390336096, 5494.7527361268685, 5509.752061157247, 5518.530924871386, 5565.053940830058, 5575.135853942636, 5409.486098820616, 5491.533219676322, 5525.281713377255, 5547.805826796063, 5570.693611851347, 5016.949830501703, 5091.84724458265, 5098.413682426512, 5124.385073791151, 5137.332146820927, 5068.645194836345, 5165.0, 5174.741262936857, 5179.482051794828, 5200.531952124308, 5168.5606723428555, 5170.198619214009, 5174.974125129388, 5191.948080519203, 5196.246544251081, 5171.0, 5173.887614162954, 5175.844724658266, 5176.0, 5194.220866869962, 5037.546620804109, 5132.820351287687, 5141.203113517411, 5144.3312369392115, 5161.948380516184, 5578.776848926038, 5588.469095435927, 5611.523020543259, 5616.5787565932305, 5646.011947909099, 5879.911801322984, 6036.15493830864, 6111.480524155452, 6136.96931515344, 6161.599496032788, 6053.515718742534, 6077.604955677867, 6110.3765049759795, 6136.733532366115, 6250.499960003234, 5686.545076393879, 5703.030484817591, 5712.857178570527, 5725.112607545837, 5742.770289188427, 6313.40022697843, 6325.5255855811, 6357.96821015892, 6365.981442969195, 6380.744770209232, 5798.739056742373, 5840.678762668009, 5857.531397488276, 6056.848578785478, 6061.0, 6086.756529738849, 6102.913431175913, 6114.724837382329, 6122.602030868068, 6189.35011823761, 6090.36051214625, 6110.686202466491, 6120.843333897677, 6130.6628135452975, 6134.926387882192, 6095.878082438327, 6114.296855861544, 6116.0, 6157.076438534166, 6171.382861713882, 4801.4958429365115, 4836.12949669063, 4843.24929635907, 4849.660523763373, 4885.975570122127, 4370.912581748347, 4380.0, 4400.581944715247, 4409.0, 4416.1609294233995, 5742.08126699726, 5742.799002034909, 5743.827685169368, 5748.913766293509, 5755.65466072037, 6028.5478589106, 6104.610739188311, 6134.559047376611, 6151.5386346024225, 6234.875302493925, 5691.8292451226525, 5748.597598168171, 5749.338826034976, 5771.0, 5826.271716035496, 5267.920981185285, 5315.202719592092, 5361.892762144736, 5400.83797486076, 5406.783728650888, 5340.851716880889, 6235.750569977241, 6257.217847769029, 6280.937190628035, 6300.550873299076, 5349.251104845403, 5987.9401205989125, 6055.091736239599, 6075.2405949256345, 6202.596831205957, 6250.4374606285655, 6262.749490020348, 6273.592216505913, 6282.654454005074, 6283.403076707706, 5457.399686034612, 5549.278593782944, 6094.085887116968, 6100.267967843887, 6102.0541816018585, 6021.0, 6081.969590152021, 6210.285817130907, 6211.627302361872, 6215.906761398673, 4901.3383193268455, 6009.489193418433, 6039.0, 6042.274927008787, 6047.485963693135, 4683.484816670096, 5788.594798364243, 5917.822465326047, 5926.67403292823, 5955.67243801595, 5494.532964698045, 5693.3168019837885, 5814.651120932757, 5852.502537284378, 5865.296164460292, 5844.590878638624, 5937.198478205387, 5951.821445356646, 6014.609050411709, 6047.818565443044, 5679.432056794288, 5704.857378565569, 5708.686022268815, 5726.914096288642, 5753.827385178452], "value": 5580.61650645414, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [452.03039480314726, 453.2046258815778, 454.5477250136115, 459.21015852733285, 489.53983255739604, 40349.79825100874, 42370.57629423705, 42397.78801105998, 43996.0, 44251.77874110633, 42714.786426067825, 42860.571394286046, 43005.0, 43066.78466607662, 43144.352834707504, 9291.72124836256, 9482.762930926747, 9492.288078394113, 9506.619735210617, 10788.406637634927, 10845.891541084568, 11098.0, 11113.611023614176, 11123.27698699582, 11132.276402033882, 11099.0, 11147.888521114806, 11157.888421115807, 11160.162987775908, 11176.720581985433, 11035.503402346914, 11090.778184436347, 11110.222284440133, 11114.388708621023, 11120.777584448346, 10833.891661083446, 10990.340579565252, 11049.060829829394, 11094.667159985212, 11095.833562496488, 36839.0, 37022.259554809025, 37054.0, 37056.81471592652, 37162.44256336157, 3611.3138503684218, 3771.264603402338, 3978.124812541236, 3995.960040399588, 4116.855910043134, 28210.461058504832, 28934.42131157386, 29016.12951611434, 29026.12921612355, 29318.41363172746, 3145.5438961350706, 3184.26761844777, 3230.80615163091, 3323.833808309575, 3332.350191712617, 426835.0, 429177.85411072744, 430628.0, 431158.0, 435534.0, 50927.49072509302, 55437.0, 55560.72219638876, 55601.721991389786, 55784.16323755147, 55177.72411137919, 55382.446175538535, 55400.72299638476, 55631.721841390536, 55787.72106139443, 15392.230388480531, 15565.22173891301, 15583.298751556207, 15630.843691562939, 15632.843671563367, 10758.892411075945, 11014.724631884266, 11782.528698852122, 11986.76026479483, 12137.5144994201, 17711.822881771273, 17753.757236993286, 17848.732269015974, 17971.281148753904, 18019.819801801816, 6682.863913134779, 7443.776686699408, 7543.7736867894055, 7645.438778009429, 7774.611269436506, 825.3768404854417, 838.6435764799936, 842.6629348260744, 844.6663567890648, 857.1942374168262, 29681.954067808525, 29973.550396744067, 30137.547936780968, 30178.54732179019, 30593.847030764704, 1036.388530766851, 1038.553422028535, 1058.8411738239326, 1067.514281002142, 1081.389015206406, 15563.61090972712, 15615.687686246212, 15642.687146257238, 15713.371465141496, 15961.361545538048, 599166.0, 599365.0, 602361.0, 604966.0, 606830.0, 59309.70345148247, 60202.096968545506, 60204.0, 60230.0, 60284.0, 1399.2234309958071, 1408.5140626483847, 1434.3473719457622, 1436.102435977493, 1443.3937746146644, 28731.425371492034, 29189.270268243465, 29819.403611927206, 30047.09858704155, 30389.848050759603, 51412.0, 51652.22521662103, 51811.0, 51874.0, 51924.74037629788, 403549.0, 405947.0, 406064.0, 407281.0, 407574.0, 24323.0, 25042.123525676514, 26322.210333690018, 26694.59958100669, 26725.72388417844, 42238.0, 43215.78392108019, 43303.0, 43465.56534434615, 43817.0, 34875.0, 35065.948021559394, 35745.46381804223, 36451.22600616016, 36455.45316820303, 35777.926662200174, 36031.81984090063, 36402.0, 36735.448968266035, 37000.62999369972, 32432.35135297328, 35198.64801351954, 35754.821225893706, 35760.92717218488, 36719.63280367269, 31409.8429507851, 32503.0, 32554.674453255164, 32605.510917335785, 32648.51027234546, 21860.89069554642, 21933.232336868132, 22546.77453225447, 22625.434364141027, 22878.741669208353], "value": 19467.695810998954, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.0924069696698, 363.8126364922065, 397.4554859842015, 408.82011914757487, 423.908859595187, 19751.0, 20293.797062029375, 20839.27062552809, 21196.364109076712, 21383.93080345982, 11508.194426390157, 12011.661225427055, 12100.273983560992, 12104.576339828107, 21395.0, 5031.798728050882, 5327.413984461706, 5336.199570064483, 5336.466353364652, 5356.625036247464, 5056.620753443488, 5230.189320655304, 5241.68549887008, 5291.417944026154, 5297.8940421191555, 4205.768682722449, 5260.973695131538, 5271.28837606922, 5303.23103150043, 5478.863028424282, 4468.8882777930485, 4576.542345765413, 4876.634252431047, 4903.730294833783, 5080.339555857733, 4480.8349829044355, 4614.169449499089, 5153.407358153785, 5181.766820493087, 5202.505761952609, 13063.216207027608, 13126.540571079966, 23450.296491105295, 24432.51134977308, 25470.490590188278, 2227.465408301996, 2588.935276618081, 2652.82756620819, 2789.581562765581, 2881.6109825173753, 9436.103570160893, 9881.357711748786, 9999.40003599779, 10277.691669249934, 10467.633632822815, 1586.0562965035786, 1830.9359172429033, 1849.3527265457117, 1891.6311319292743, 1893.3751861885544, 122966.15550766746, 124755.37622311921, 125440.0, 135962.0, 140999.0, 11742.941285293518, 11887.16789824704, 12001.399580125928, 12067.758644827054, 12188.634340969786, 15547.922260388626, 15606.29771660278, 15621.14083725406, 15632.2183890805, 15647.765283520755, 8531.786705332417, 8684.39209255346, 8707.782305442415, 8745.606447709868, 8826.382153249211, 8333.250007499355, 8347.666093356198, 8353.832923341499, 8447.619857106445, 8508.404411691246, 4776.164171270014, 4803.735794531264, 4824.903501929942, 4843.75781210938, 4888.853334399973, 1825.2516468247954, 2027.9087441065187, 2037.7962203779502, 2060.8248298894464, 2061.4333106838912, 905.3296667648178, 944.6079876851168, 994.7065615643257, 999.9900001000043, 1069.9572017119383, 21022.789772102387, 21356.932153392267, 21382.57234855294, 21483.78516214818, 21492.78507214908, 838.3460900497622, 912.5665308978182, 1018.3228153277987, 1043.087298613713, 1049.6483677967967, 10572.682819515427, 10783.78432431347, 10803.0, 10992.340459572451, 11028.834567481494, 716845.0, 726138.0, 728112.0, 731525.6847431564, 744258.0, 93694.0, 108429.0, 136315.0, 137740.31129844286, 158931.41068589166, 957.363353370015, 1011.2163073617858, 1037.7353774787382, 1041.9944753313089, 1057.0644979193469, 16484.34062637481, 18679.90660046691, 19060.80939190646, 19210.423687289403, 19512.9024354883, 53891.0, 53900.46099539111, 57004.0, 60089.0, 60943.390566093774, 78937.60531197308, 79457.60271198607, 79744.80382794379, 80080.0, 81241.0, 7742.380609551335, 8256.917430825615, 11514.596989105341, 12205.633830985085, 12551.811722824348, 13159.671008224488, 13420.731585368043, 13426.261555614536, 13708.725825483634, 14000.439982400998, 11272.943635281772, 11632.88367116318, 11673.0, 12009.678935316933, 12066.034717222778, 11131.443427828739, 11354.489047993025, 11566.0, 11782.351970641697, 11835.940820295844, 11348.262362946381, 11647.825282620597, 11755.0, 12048.75902481928, 12131.696707582028, 12161.878381216075, 12197.817032744339, 12330.445129969352, 12450.439730211981, 12456.252624842538, 7281.286543862562, 7371.336579707852, 7779.4554381192775, 7814.843703126019, 8241.299489543457], "value": 9598.859975397938, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1264.6585421936077, 1290.167841742077, 1414.2928535732135, 1444.9060811047282, 1446.638340414896, 7413.6293185340655, 7657.3874090072795, 7915.12933577306, 8327.08402075772, 8343.666253349875, 7850.528968261894, 8134.349252059836, 8155.510669359843, 8258.91741082589, 8331.250187483125, 2276.1350686739015, 2316.5830150572892, 2319.988400058006, 2323.0243297814873, 2327.4763178284834, 1940.7282980382759, 2000.30989308689, 2278.5784629843447, 2313.9537209255805, 2323.53529294141, 2042.346449136277, 2201.9889900550475, 2276.7950884420397, 2284.9885750571307, 2290.4960908600083, 2235.10595761695, 2258.796708296253, 2261.061659411359, 2261.0842608743487, 2266.764613285763, 2170.2621108823078, 2253.763354847734, 2291.598970180212, 2307.3770082077745, 2313.7339205991357, 8235.094139644634, 8249.670013199464, 8330.333573314121, 8351.08138104808, 8369.079401265855, 5009.749512524396, 5178.300929374524, 5185.662931909452, 5189.740512974374, 5191.221316802472, 3336.2493438976035, 3420.538227339302, 3446.138465383654, 3494.248736521635, 3498.195415054526, 1204.9277043377426, 1206.5223883568588, 1245.371087600765, 1251.7496500699897, 1262.059765474727, 10495.0, 10507.422091784949, 10560.52477638508, 10631.681049568526, 10730.678079657622, 4146.91706165875, 4360.9127817444105, 4413.867583972486, 4428.800703968329, 4434.401355816988, 8425.662973481114, 8501.14988501145, 8507.191816777397, 8508.617112229964, 8518.361122915807, 5032.974835125801, 5039.496050395004, 5053.166227572409, 5055.570276526463, 5059.974700126476, 4577.336286238543, 4641.976790116028, 4717.858464246078, 4718.245080787126, 4719.244920812654, 3094.3965926644537, 3618.222082252328, 3677.8598634423415, 3696.5194524711615, 3719.8512059517857, 1044.9164066874785, 1143.7998350288667, 1150.5742875136252, 1151.067635215478, 1153.117864833403, 771.4792515052317, 864.6282098697494, 865.948043117415, 867.2195024477894, 927.8097989912052, 5376.086065368897, 5705.286839145107, 5735.1074145531875, 5736.856578585569, 5846.093855452412, 946.8485042393185, 975.5658731864253, 986.161762501882, 998.3610489286717, 1009.2279406254221, 3215.437298472758, 3446.500257462704, 3717.8141092945243, 3827.655511004023, 3871.1483473635753, 9447.90552094484, 9721.9027809721, 9788.853167202498, 9796.510174491246, 9803.460809655395, 9719.514024298756, 9732.90267097334, 9739.610415583298, 9748.268879833899, 9752.951235243778, 7153.891146872244, 7573.583452910033, 7574.545527268381, 7607.0, 7706.537607743553, 5311.867203319948, 5326.25432439451, 5424.0, 5605.103183490622, 5651.519620832111, 8859.64561417536, 9067.04795996411, 9113.270938325051, 9137.949135849462, 9142.862857057282, 8671.696490622799, 8998.14517620825, 9106.408083474553, 9183.77040573991, 9283.907160928575, 7014.86046755724, 7153.713851445884, 7157.785266442015, 7164.176119746296, 7170.89243661356, 7664.885026724715, 7674.0, 7728.497647652885, 7738.071431428265, 7743.341815945708, 6021.217241758543, 6240.344763799917, 6762.42519385838, 6999.790006299819, 7095.042169307284, 6681.231658359351, 6685.231198412245, 6881.174259088942, 6883.621400823003, 6917.688704008432, 6092.817215483543, 6250.843728906813, 6326.367363263636, 6340.714667839866, 6427.357264273535, 4921.803127874845, 4962.0, 4973.950260497349, 5002.499750024968, 5052.166392545336, 4847.151748443937, 4910.803567857246, 4920.8769780755765, 4967.4535801062575, 5117.232415137759], "value": 4315.84493994358, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.5933798118221, 357.3353562373984, 374.8613013185122, 377.57522786864774, 381.03027794263596, 4405.427294451717, 5378.919316210255, 5491.28613280274, 5518.19986102015, 5518.847649416731, 4848.369711937452, 5071.301114126772, 5077.771500282487, 5261.97391508655, 5475.233467314569, 3473.6700013498803, 3534.6111927687934, 4237.7669228192435, 4240.512341080785, 4245.9575404246025, 3480.443129099345, 4144.259411047367, 4157.9605098725315, 4168.6039826216465, 4201.264778663737, 4042.2521833460755, 4231.0, 4242.4272723182285, 4244.533101358864, 4274.670304683939, 3961.564227934925, 4197.412362269285, 4236.957630423687, 4244.533101358848, 4258.808353624064, 2820.2667306500457, 3253.6908993645566, 3523.489094081344, 3689.24370504046, 3703.2408356286896, 4393.384926110347, 4792.688475249098, 5147.327118686442, 5175.404828444702, 5312.3890752563175, 4152.937705934383, 4489.236829738952, 4712.9969762851, 4719.504452032522, 4735.171345014609, 5517.641353312022, 5697.173909783059, 5746.569007324468, 5747.62640428375, 5754.597178197528, 3627.873024444158, 3897.4020651532737, 3910.374340105598, 3915.7454765440157, 3919.039835240356, 5769.365369809318, 5875.768327419902, 5952.672603006833, 6044.969775151096, 6059.7273122709585, 3377.932441351159, 3585.296983932611, 3710.888673339804, 3754.1553150541454, 3928.2929072767174, 3550.786952782841, 3692.929050575303, 3749.962500374961, 3974.8608798691907, 3982.4623675803396, 4552.385427967249, 4563.780665189357, 4638.758203230395, 4662.696924699883, 4673.182193116191, 4762.238041913277, 5377.892442151135, 5496.6701997880255, 5730.627509211888, 5812.680302583399, 1134.4384529657707, 1246.0654509118162, 1258.0187453786061, 1293.8512071111754, 1312.287464858369, 818.9303909167668, 830.3481766813023, 852.4714676900361, 880.6037283222576, 882.179572997106, 4566.105066397407, 5198.792048318101, 5237.895242095213, 5259.948010397859, 5266.631335806457, 5007.69953802773, 5253.605979551549, 5693.526948561374, 5714.856728871535, 5719.027765279912, 4700.600448961876, 4823.541763532458, 5140.457862641193, 5218.869528261824, 5243.4232234454175, 2692.488427198826, 2823.8729257183477, 2924.7952643314766, 2943.8518977598756, 2964.0515035188964, 5080.54275115234, 5447.4824891635235, 5501.889962200734, 5772.556860784804, 5855.696063393402, 5238.135707608279, 5257.027449921777, 5479.945200548023, 5835.270591176103, 5860.853478663067, 4864.708117512961, 5716.771329146871, 5763.740631671585, 5795.449432303924, 5903.26209223847, 5216.843494695166, 5705.030144875298, 5708.200851880823, 5721.141828725558, 5740.368559458373, 4859.416869975626, 5572.91640625399, 5588.217649528988, 5603.35561410443, 5612.494875461228, 5725.76895967369, 5799.072148456226, 5940.257467816523, 5974.761009559569, 6159.4456498915315, 3483.5993860706344, 3863.879474952232, 3908.550516690503, 3917.5494818096286, 3937.4684417603257, 4987.2819313474965, 5535.833924982257, 5684.550439637866, 5882.588218824641, 5937.643741375531, 5425.511703946664, 5498.230247765236, 5581.469760372758, 5705.834740639273, 5845.035569131216, 5425.891482170414, 5773.884522309614, 5802.332731735904, 5806.65160090396, 5820.526276332626, 4594.4838203393465, 5301.602379821452, 5569.944300556943, 5659.292588426447, 5675.545956323567, 4633.4208223972, 5114.590832733298, 5410.269613602113, 5700.463293834204, 5797.782465682254, 5349.786008559614, 5362.892742145214, 5606.486248712743, 5671.319441666861, 5671.489565939085], "value": 4124.343293402419, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [703.1175874277781, 716.0, 731.4623751542615, 823.1850468036644, 828.1594181905364, 14749.336279867404, 15576.376944922218, 15625.140617266074, 15673.451429199995, 15710.92144539277, 13565.118267312619, 13675.521356752515, 13720.862791372108, 13736.107153035045, 13737.725245495085, 666.1839246922506, 690.5511417578564, 839.5004972041626, 858.2704701004143, 873.7116751471999, 792.9770595931242, 856.8457677618027, 867.2151702709058, 867.6702852915884, 870.5386145342978, 872.075599864146, 926.0970553710146, 932.3799673217336, 932.8507438809792, 933.6732143749701, 908.123660667459, 916.3722849847876, 923.8937522184967, 924.9815003699888, 925.0841666749936, 687.3744892148121, 689.1316940654812, 689.1902015132199, 690.3200347657553, 691.5470366909682, 14762.70474590502, 14828.777568336483, 14880.181590012546, 15041.699166016619, 15910.0, 14174.43302267908, 14395.928020359832, 14498.275086245645, 14643.0, 14649.414023439049, 11670.0, 11711.297322160697, 11715.289140759083, 11985.940070299679, 12299.740568749288, 3709.4806727058235, 3731.477593136963, 3745.606711295302, 3767.190054138346, 3888.6694630956404, 97500.53749193768, 98433.50783246038, 101232.0, 101293.0, 101558.0, 11030.117590592734, 11068.0, 11183.888161118448, 11238.133108007389, 11351.091912646969, 22717.318480445614, 22831.0, 22890.0, 23025.88487057554, 23025.884870575876, 7509.699612015567, 7723.218272197728, 7726.0, 7753.263439973193, 7789.221077892165, 4199.2441360554785, 4299.376590394438, 4328.394024836525, 4331.523532411432, 4337.587929146726, 3442.0, 3515.789052656849, 3521.0669172669263, 3537.080359106599, 3552.431610942237, 632.8164832198611, 645.2418408370146, 654.5876098058288, 660.389140045456, 664.3489380407228, 535.8044313825426, 568.3009897825615, 604.3050491934223, 608.3394018656356, 629.8382121748796, 9461.195798357217, 10185.541650625739, 10192.827824800243, 10294.433806140734, 10362.740931476774, 552.7402121003122, 651.4430162211336, 659.3768888400416, 691.7336825322186, 696.8362434827811, 4871.098846713369, 4956.975215123974, 4966.503349665005, 4973.676711013773, 4986.601071914238, 101981.0, 104006.0, 105081.94918050722, 105853.0, 107953.46023269833, 92241.0, 92986.0, 93263.66840829034, 94166.0, 95366.52316738373, 79360.20639793643, 79361.0, 80274.19725802784, 80519.59740201262, 80593.0, 9527.47598882068, 9598.568064436977, 9601.807963840545, 9625.133737963617, 9714.465704386326, 53046.204306934655, 53597.0, 54022.72988635032, 54115.72942135264, 54643.18035229395, 69617.69014253633, 70887.64556177186, 71982.0, 72113.27886721065, 72117.27882721106, 10906.781864362827, 11435.428228588704, 11507.712307192387, 11517.193796434169, 11674.0, 12389.442475088823, 12588.559400420942, 15058.472953446577, 15124.848751512343, 15539.300731467338, 12011.879881201075, 13050.282234476816, 13594.184348939096, 13615.978801589723, 14215.431382744988, 11384.772304554028, 13103.934480327538, 13521.391537380645, 13689.657758556115, 14054.929725351309, 11212.49543770516, 13200.405981731037, 13620.455181792617, 13743.450261989408, 13884.72230555363, 10958.397288149228, 11104.278221915549, 11252.0, 11322.150838686966, 11607.883921160681, 8956.776080598038, 10688.448307712415, 10839.078678312117, 10857.619983300547, 10890.346579205274], "value": 7481.713554023474, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1579.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 120.0, 117.0, 117.0, 118.0, 117.0, 119.0, 119.0, 118.0, 119.0], "value": 117.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 112.0, 111.0, 150.0, 111.0, 115.0, 114.0, 111.0, 135.0, 113.0], "value": 122.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 209.0, 222.0, 206.0, 198.0, 196.0, 196.0, 193.0, 220.0, 261.0], "value": 209.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 82.0, 82.0, 109.0, 65.0, 59.0, 60.0, 60.0, 73.0, 61.0], "value": 75.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 71.0, 85.0, 73.0, 70.0, 72.0, 82.0, 72.0, 72.0, 80.0], "value": 76.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 88.0, 89.0, 87.0, 98.0, 113.0, 116.0, 89.0, 77.0, 127.0], "value": 97.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 93.0, 140.0, 153.0, 107.0, 155.0, 114.0, 96.0, 98.0, 118.0], "value": 122.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 93.0, 93.0, 91.0, 105.0, 146.0, 123.0, 91.0, 126.0, 146.0], "value": 110.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 61.0, 60.0, 63.0, 62.0, 62.0, 62.0, 61.0, 61.0], "value": 61.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 77.0, 103.0, 122.0, 80.0, 73.0, 71.0, 71.0, 73.0, 73.0], "value": 81.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 89.0, 92.0, 88.0, 91.0, 88.0, 87.0, 89.0, 90.0, 89.0], "value": 89.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 145.0, 145.0, 152.0, 149.0, 159.0, 157.0, 155.0, 206.0, 161.0], "value": 157.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 180.0, 174.0, 174.0, 200.0, 210.0, 175.0, 173.0, 176.0, 159.0], "value": 179.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 85.0, 87.0, 88.0, 73.0, 63.0, 85.0, 90.0, 88.0], "value": 79.4, "unit": "score"}]}]} 05:17:11 INFO - Return code: 0 05:17:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:17:11 ERROR - # TBPL SUCCESS # 05:17:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:17:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:17:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:17:11 INFO - 2017-01-26 05:17:11.673 screenresolution[1929:19157] starting screenresolution argv=screenresolution get 05:17:11 INFO - 2017-01-26 05:17:11.675 screenresolution[1929:19157] Display 0: 1600x1200x32@60 05:17:11 INFO - 2017-01-26 05:17:11.681 screenresolution[1930:19160] starting screenresolution argv=screenresolution list 05:17:11 INFO - Available Modes on Display 0 05:17:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:17:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:17:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:17:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:17:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:17:11 INFO - Intel Iris: 05:17:11 INFO - Chipset Model: Intel Iris 05:17:11 INFO - Type: GPU 05:17:11 INFO - Bus: Built-In 05:17:11 INFO - VRAM (Dynamic, Max): 1536 MB 05:17:11 INFO - Vendor: Intel (0x8086) 05:17:11 INFO - Device ID: 0x0a2e 05:17:11 INFO - Revision ID: 0x0009 05:17:11 INFO - Displays: 05:17:11 INFO - Display: 05:17:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:17:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:17:11 INFO - Display Serial Number: 1600x1200 60 05:17:11 INFO - Main Display: Yes 05:17:11 INFO - Mirror: Off 05:17:11 INFO - Online: Yes 05:17:11 INFO - Rotation: Supported 05:17:11 INFO - Return code: 0 05:17:11 INFO - Running post-action listener: _resource_record_post_action 05:17:11 INFO - [mozharness: 2017-01-26 13:17:11.921456Z] Finished run-tests step (success) 05:17:11 INFO - Running post-run listener: _resource_record_post_run 05:17:11 INFO - Total resource usage - Wall time: 1200s; CPU: 55.0%; Read bytes: 2286592; Write bytes: 556573184; Read time: 16; Write time: 1713 05:17:11 INFO - TinderboxPrint: CPU usage
54.6% 05:17:11 INFO - TinderboxPrint: I/O read bytes / time
2,286,592 / 16 05:17:11 INFO - TinderboxPrint: I/O write bytes / time
556,573,184 / 1,713 05:17:11 INFO - TinderboxPrint: CPU idle
2,181.9 (45.4%) 05:17:11 INFO - TinderboxPrint: CPU system
965.2 (20.1%) 05:17:11 INFO - TinderboxPrint: CPU user
1,654.6 (34.5%) 05:17:11 INFO - TinderboxPrint: Swap in / out
253,661,184 / 0 05:17:11 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 251849216; Write bytes: 251822080; Read time: 18138; Write time: 548 05:17:11 INFO - run-tests - Wall time: 1179s; CPU: 55.0%; Read bytes: 2278400; Write bytes: 303301120; Read time: 16; Write time: 1154 05:17:12 INFO - Running post-run listener: _upload_blobber_files 05:17:12 INFO - Blob upload gear active. 05:17:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:17:12 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 05:17:12 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'] 05:17:12 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 05:17:12 INFO - (blobuploader) - INFO - Open directory for files ... 05:17:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:17:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:17:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:17:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:17:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:17:14 INFO - (blobuploader) - INFO - Done attempting. 05:17:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:17:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:17:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:17:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:17:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:17:15 INFO - (blobuploader) - INFO - Done attempting. 05:17:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:17:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:17:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:17:16 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:17:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:17:16 INFO - (blobuploader) - INFO - Done attempting. 05:17:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:17:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:17:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:17:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:17:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:17:18 INFO - (blobuploader) - INFO - Done attempting. 05:17:18 INFO - (blobuploader) - INFO - Iteration through files over. 05:17:18 INFO - Return code: 0 05:17:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:17:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:17:18 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/011ca71e7a638412265c37f7d5d1ca38a2fa8d0f959391a58c4f2280623479578d6cfcd7c8f7492b33c7fb373996e8e1553512b79bb9ee6977c261841272520c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd2cb3c8d38abe89d9a0d8cf7205e6471b42b6f8d62b9834c004cb5a54e01d472bca729b432dba1e1fac070d7aaf364ce584687e44780a366740992ec6675f76", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3edf601484a1bf88ce066991dca71406435c57db85c8de1c8cbc31aef7a9b247359636e041e2a94c141981a99246d65dabee1e42ded71dada3422ae65fd583a2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/934704c7bf969d47811d61ab24fcac93702b82d45146d905b3a1aefd95127089efccf2ddbdcbce790e24f802edee853225c3bed6d2b8ec7def96af10dbd198e0"} 05:17:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:17:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:17:18 INFO - Contents: 05:17:18 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/011ca71e7a638412265c37f7d5d1ca38a2fa8d0f959391a58c4f2280623479578d6cfcd7c8f7492b33c7fb373996e8e1553512b79bb9ee6977c261841272520c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd2cb3c8d38abe89d9a0d8cf7205e6471b42b6f8d62b9834c004cb5a54e01d472bca729b432dba1e1fac070d7aaf364ce584687e44780a366740992ec6675f76", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3edf601484a1bf88ce066991dca71406435c57db85c8de1c8cbc31aef7a9b247359636e041e2a94c141981a99246d65dabee1e42ded71dada3422ae65fd583a2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/934704c7bf969d47811d61ab24fcac93702b82d45146d905b3a1aefd95127089efccf2ddbdcbce790e24f802edee853225c3bed6d2b8ec7def96af10dbd198e0"} 05:17:18 INFO - Running post-run listener: copy_logs_to_upload_dir 05:17:18 INFO - Copying logs to upload dir... 05:17:18 INFO - mkdir: /builds/slave/test/build/upload/logs 05:17:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.494201 ========= master_lag: 0.08 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-01-26 05:17:18.815876) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-26 05:17:18.819830) ========= 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.HTUOfOR6OQ/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.vEcROtkoL7/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/011ca71e7a638412265c37f7d5d1ca38a2fa8d0f959391a58c4f2280623479578d6cfcd7c8f7492b33c7fb373996e8e1553512b79bb9ee6977c261841272520c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd2cb3c8d38abe89d9a0d8cf7205e6471b42b6f8d62b9834c004cb5a54e01d472bca729b432dba1e1fac070d7aaf364ce584687e44780a366740992ec6675f76", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3edf601484a1bf88ce066991dca71406435c57db85c8de1c8cbc31aef7a9b247359636e041e2a94c141981a99246d65dabee1e42ded71dada3422ae65fd583a2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/934704c7bf969d47811d61ab24fcac93702b82d45146d905b3a1aefd95127089efccf2ddbdcbce790e24f802edee853225c3bed6d2b8ec7def96af10dbd198e0"} build_url:https://queue.taskcluster.net/v1/task/GzGlSoTBTU6Kp7CTkxdOlA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011405 build_url: 'https://queue.taskcluster.net/v1/task/GzGlSoTBTU6Kp7CTkxdOlA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/011ca71e7a638412265c37f7d5d1ca38a2fa8d0f959391a58c4f2280623479578d6cfcd7c8f7492b33c7fb373996e8e1553512b79bb9ee6977c261841272520c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd2cb3c8d38abe89d9a0d8cf7205e6471b42b6f8d62b9834c004cb5a54e01d472bca729b432dba1e1fac070d7aaf364ce584687e44780a366740992ec6675f76", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3edf601484a1bf88ce066991dca71406435c57db85c8de1c8cbc31aef7a9b247359636e041e2a94c141981a99246d65dabee1e42ded71dada3422ae65fd583a2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/934704c7bf969d47811d61ab24fcac93702b82d45146d905b3a1aefd95127089efccf2ddbdcbce790e24f802edee853225c3bed6d2b8ec7def96af10dbd198e0"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-26 05:17:18.856435) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-26 05:17:18.856822) ========= 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.HTUOfOR6OQ/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.vEcROtkoL7/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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.005256 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-26 05:17:18.905450) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-26 05:17:18.905810) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-26 05:17:18.906150) ========= ========= Total master_lag: 0.23 =========