builder: autoland_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0153 starttime: 1474907593.61 results: success (0) buildid: 20160926071051 builduid: 3ab86d85e2c84be190194f7a2ebafa47 revision: ee066384095172f059aab32ed55839e66372cce5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-26 09:33:13.610248) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-26 09:33:13.610686) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-26 09:33:13.610973) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-26 09:33:13.636349) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 09:33:13.636625) ========= 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.fEpmAsTJQr/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.uitDbdXuIn/Listeners TMPDIR=/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-09-26 09:33:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 12.5M=0.001s 2016-09-26 09:33:13 (12.5 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.104173 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 09:33:13.763792) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 09:33:13.767151) ========= 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.fEpmAsTJQr/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.uitDbdXuIn/Listeners TMPDIR=/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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.028695 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 09:33:13.817547) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 09:33:13.820934) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev ee066384095172f059aab32ed55839e66372cce5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev ee066384095172f059aab32ed55839e66372cce5 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.fEpmAsTJQr/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.uitDbdXuIn/Listeners TMPDIR=/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-09-26 09:33:13,897 truncating revision to first 12 chars 2016-09-26 09:33:13,898 Setting DEBUG logging. 2016-09-26 09:33:13,898 attempt 1/10 2016-09-26 09:33:13,898 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/ee0663840951?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-26 09:33:14,249 unpacking tar archive at: autoland-ee0663840951/testing/mozharness/ program finished with exit code 0 elapsedTime=0.615680 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 09:33:14.459884) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-26 09:33:14.463249) ========= script_repo_revision: ee066384095172f059aab32ed55839e66372cce5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-26 09:33:14.463798) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-26 09:33:14.464077) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-26 09:33:14.483057) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-09-26 09:33:14.483491) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.fEpmAsTJQr/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.uitDbdXuIn/Listeners TMPDIR=/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 09:33:14 INFO - MultiFileLogger online at 20160926 09:33:14 in /builds/slave/test 09:33:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 09:33:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:33:14 INFO - {'append_to_log': False, 09:33:14 INFO - 'base_work_dir': '/builds/slave/test', 09:33:14 INFO - 'blob_upload_branch': 'Autoland', 09:33:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:33:14 INFO - 'branch': 'Autoland', 09:33:14 INFO - 'buildbot_json_path': 'buildprops.json', 09:33:14 INFO - 'config_files': ('talos/mac_config.py',), 09:33:14 INFO - 'default_actions': ('clobber', 09:33:14 INFO - 'read-buildbot-config', 09:33:14 INFO - 'download-and-extract', 09:33:14 INFO - 'populate-webroot', 09:33:14 INFO - 'create-virtualenv', 09:33:14 INFO - 'install', 09:33:14 INFO - 'run-tests'), 09:33:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:33:14 INFO - 'download_minidump_stackwalk': True, 09:33:14 INFO - 'download_symbols': 'ondemand', 09:33:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:33:14 INFO - 'tooltool.py': '/tools/tooltool.py', 09:33:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:33:14 INFO - '/tools/misc-python/virtualenv.py')}, 09:33:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:33:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:33:14 INFO - 'installer_path': 'installer.exe', 09:33:14 INFO - 'log_level': 'info', 09:33:14 INFO - 'log_name': 'talos', 09:33:14 INFO - 'log_to_console': True, 09:33:14 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:33:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:33:14 INFO - 'opt_config_files': (), 09:33:14 INFO - 'pip_index': False, 09:33:14 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:33:14 INFO - 'cmd': ('bash', 09:33:14 INFO - '-c', 09:33:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:33:14 INFO - 'enabled': True, 09:33:14 INFO - 'halt_on_failure': False, 09:33:14 INFO - 'name': 'check_screen_resolution'},), 09:33:14 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:33:14 INFO - 'cmd': ('bash', 09:33:14 INFO - '-c', 09:33:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:33:14 INFO - 'enabled': True, 09:33:14 INFO - 'halt_on_failure': False, 09:33:14 INFO - 'name': 'check_screen_resolution'},), 09:33:14 INFO - 'run_cmd_checks_enabled': True, 09:33:14 INFO - 'sps_profile': False, 09:33:14 INFO - 'sps_profile_interval': 0, 09:33:14 INFO - 'suite': 'dromaeojs-e10s', 09:33:14 INFO - 'system_bits': '32', 09:33:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:33:14 INFO - 'title': 't-yosemite-r7-0153', 09:33:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:33:14 INFO - 'use_talos_json': True, 09:33:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:33:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:33:14 INFO - 'work_dir': 'build'} 09:33:14 INFO - [mozharness: 2016-09-26 16:33:14.686307Z] Running clobber step. 09:33:14 INFO - Running pre-action listener: _resource_record_pre_action 09:33:14 INFO - Running main action method: clobber 09:33:14 INFO - rmtree: /builds/slave/test/build 09:33:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:33:16 INFO - Running post-action listener: _resource_record_post_action 09:33:16 INFO - [mozharness: 2016-09-26 16:33:16.848649Z] Finished clobber step (success) 09:33:16 INFO - [mozharness: 2016-09-26 16:33:16.848777Z] Running read-buildbot-config step. 09:33:16 INFO - Running pre-action listener: _resource_record_pre_action 09:33:16 INFO - Running main action method: read_buildbot_config 09:33:16 INFO - Using buildbot properties: 09:33:16 INFO - { 09:33:16 INFO - "project": "", 09:33:16 INFO - "product": "firefox", 09:33:16 INFO - "script_repo_revision": "production", 09:33:16 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs-e10s", 09:33:16 INFO - "repository": "", 09:33:16 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs-e10s", 09:33:16 INFO - "buildid": "20160926071051", 09:33:16 INFO - "pgo_build": "False", 09:33:16 INFO - "basedir": "/builds/slave/test", 09:33:16 INFO - "buildnumber": 206, 09:33:16 INFO - "slavename": "t-yosemite-r7-0153", 09:33:16 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 09:33:16 INFO - "platform": "yosemite_r7", 09:33:16 INFO - "scheduler": "tests-autoland-macosx64-talos-8-3600", 09:33:16 INFO - "branch": "autoland", 09:33:16 INFO - "repo_path": "integration/autoland", 09:33:16 INFO - "revision": "ee066384095172f059aab32ed55839e66372cce5", 09:33:16 INFO - "stage_platform": "macosx64", 09:33:16 INFO - "builduid": "3ab86d85e2c84be190194f7a2ebafa47", 09:33:16 INFO - "slavebuilddir": "test" 09:33:16 INFO - } 09:33:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/M1sX-InQRyWL7FMjniO_HQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 09:33:16 INFO - Running post-action listener: _resource_record_post_action 09:33:16 INFO - [mozharness: 2016-09-26 16:33:16.852106Z] Finished read-buildbot-config step (success) 09:33:16 INFO - [mozharness: 2016-09-26 16:33:16.852191Z] Running download-and-extract step. 09:33:16 INFO - Running pre-action listener: _resource_record_pre_action 09:33:16 INFO - Running main action method: download_and_extract 09:33:16 INFO - mkdir: /builds/slave/test/build/tests 09:33:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:16 INFO - trying https://queue.taskcluster.net/v1/task/M1sX-InQRyWL7FMjniO_HQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 09:33:16 INFO - Downloading https://queue.taskcluster.net/v1/task/M1sX-InQRyWL7FMjniO_HQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 09:33:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M1sX-InQRyWL7FMjniO_HQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 09:33:19 INFO - Downloaded 1199 bytes. 09:33:19 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 09:33:19 INFO - Using the following test package requirements: 09:33:19 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 09:33:19 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:33:19 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 09:33:19 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:33:19 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 09:33:19 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:33:19 INFO - u'jsshell-mac.zip'], 09:33:19 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:33:19 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 09:33:19 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 09:33:19 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:33:19 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 09:33:19 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:33:19 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 09:33:19 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:33:19 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 09:33:19 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:33:19 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 09:33:19 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:33:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M1sX-InQRyWL7FMjniO_HQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 09:33:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M1sX-InQRyWL7FMjniO_HQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:33:19 INFO - Fetch https://queue.taskcluster.net/v1/task/M1sX-InQRyWL7FMjniO_HQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 09:33:20 INFO - Expected file size: 16468906 09:33:26 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 09:33:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M1sX-InQRyWL7FMjniO_HQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 09:33:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M1sX-InQRyWL7FMjniO_HQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:33:26 INFO - Fetch https://queue.taskcluster.net/v1/task/M1sX-InQRyWL7FMjniO_HQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 09:33:27 INFO - Expected file size: 16468906 09:33:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M1sX-InQRyWL7FMjniO_HQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 09:33:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M1sX-InQRyWL7FMjniO_HQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 09:33:34 INFO - Fetch https://queue.taskcluster.net/v1/task/M1sX-InQRyWL7FMjniO_HQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 09:33:34 INFO - Expected file size: 14414057 09:33: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')]} 09:33:35 INFO - trying https://queue.taskcluster.net/v1/task/M1sX-InQRyWL7FMjniO_HQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 09:33:35 INFO - Downloading https://queue.taskcluster.net/v1/task/M1sX-InQRyWL7FMjniO_HQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 09:33:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M1sX-InQRyWL7FMjniO_HQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 09:33:38 INFO - Downloaded 111597058 bytes. 09:33:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/M1sX-InQRyWL7FMjniO_HQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 09:33:38 INFO - mkdir: /builds/slave/test/properties 09:33:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:33:38 INFO - Writing to file /builds/slave/test/properties/build_url 09:33:38 INFO - Contents: 09:33:38 INFO - build_url:https://queue.taskcluster.net/v1/task/M1sX-InQRyWL7FMjniO_HQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 09:33:38 INFO - Running post-action listener: _resource_record_post_action 09:33:38 INFO - Running post-action listener: set_extra_try_arguments 09:33:38 INFO - [mozharness: 2016-09-26 16:33:38.821268Z] Finished download-and-extract step (success) 09:33:38 INFO - [mozharness: 2016-09-26 16:33:38.821362Z] Running populate-webroot step. 09:33:38 INFO - Running pre-action listener: _resource_record_pre_action 09:33:38 INFO - Running main action method: populate_webroot 09:33:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:33:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:33:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:33:38 INFO - '--tppagecycles', 09:33:38 INFO - '7'], 09:33:38 INFO - 'tests': ['tsvgm']}}, 09:33:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:33:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:33:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:33:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:33:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:33:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:33:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:38 INFO - 'talos_options': ['--disable-e10s'], 09:33:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:33:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:33:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:38 INFO - 'talos_options': ['--disable-e10s'], 09:33:38 INFO - 'tests': ['damp', 'tps']}, 09:33:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:38 INFO - 'tests': ['damp', 'tps']}, 09:33:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:33:38 INFO - 'tests': ['dromaeo_dom']}, 09:33:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:33:38 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:33:38 INFO - 'tests': ['basic_compositor_video']}, 09:33:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:33:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:33:38 INFO - 'tests': ['a11yr', 09:33:38 INFO - 'ts_paint', 09:33:38 INFO - 'tpaint', 09:33:38 INFO - 'sessionrestore', 09:33:38 INFO - 'sessionrestore_no_auto_restore', 09:33:38 INFO - 'tabpaint']}, 09:33:38 INFO - 'other-e10s': {'tests': ['a11yr', 09:33:38 INFO - 'ts_paint', 09:33:38 INFO - 'tpaint', 09:33:38 INFO - 'sessionrestore', 09:33:38 INFO - 'sessionrestore_no_auto_restore', 09:33:38 INFO - 'tabpaint']}, 09:33:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:33:38 INFO - 'ts_paint', 09:33:38 INFO - 'tpaint', 09:33:38 INFO - 'sessionrestore', 09:33:38 INFO - 'sessionrestore_no_auto_restore', 09:33:38 INFO - 'tabpaint']}, 09:33:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:33:38 INFO - 'ts_paint', 09:33:38 INFO - 'tpaint', 09:33:38 INFO - 'sessionrestore', 09:33:38 INFO - 'sessionrestore_no_auto_restore', 09:33:38 INFO - 'tabpaint']}, 09:33:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:33:38 INFO - 'tests': ['a11yr', 09:33:38 INFO - 'ts_paint', 09:33:38 INFO - 'tpaint', 09:33:38 INFO - 'sessionrestore', 09:33:38 INFO - 'sessionrestore_no_auto_restore', 09:33:38 INFO - 'tabpaint']}, 09:33:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:33:38 INFO - 'tests': ['a11yr', 09:33:38 INFO - 'ts_paint', 09:33:38 INFO - 'tpaint', 09:33:38 INFO - 'sessionrestore', 09:33:38 INFO - 'sessionrestore_no_auto_restore', 09:33:38 INFO - 'tabpaint']}, 09:33:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:33:38 INFO - 'tests': ['tsvgx', 09:33:38 INFO - 'tsvgr_opacity', 09:33:38 INFO - 'tart', 09:33:38 INFO - 'tscrollx', 09:33:38 INFO - 'cart']}, 09:33:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:33:38 INFO - 'tsvgr_opacity', 09:33:38 INFO - 'tart', 09:33:38 INFO - 'tscrollx', 09:33:38 INFO - 'cart']}, 09:33:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:38 INFO - 'talos_options': ['--disable-e10s'], 09:33:38 INFO - 'tests': ['tp5o']}, 09:33:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:38 INFO - 'tests': ['tp5o']}, 09:33:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:38 INFO - 'talos_options': ['--disable-e10s', 09:33:38 INFO - '--xperf_path', 09:33:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:33:38 INFO - 'tests': ['tp5n']}, 09:33:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:33:38 INFO - 'talos_options': ['--xperf_path', 09:33:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:33:38 INFO - 'tests': ['tp5n']}}, 09:33:38 INFO - 'talos.zip': {'path': '', 09:33:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:33:38 INFO - Running post-action listener: _resource_record_post_action 09:33:38 INFO - [mozharness: 2016-09-26 16:33:38.840154Z] Finished populate-webroot step (success) 09:33:38 INFO - [mozharness: 2016-09-26 16:33:38.840253Z] Running create-virtualenv step. 09:33:38 INFO - Running pre-action listener: _resource_record_pre_action 09:33:38 INFO - Running main action method: create_virtualenv 09:33:38 INFO - Creating virtualenv /builds/slave/test/build/venv 09:33: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 09:33:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:33:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:33:38 INFO - Using real prefix '/tools/python27' 09:33:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:33:39 INFO - Installing distribute.............................................................................................................................................................................................done. 09:33:42 INFO - Installing pip.................done. 09:33:42 INFO - Return code: 0 09:33:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:33:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:33:43 INFO - Reading from file tmpfile_stdout 09:33:43 INFO - Output received: 09:33:43 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) 09:33:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:33:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108704490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10867a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80c0c56ea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108518d30>, '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 0x10833edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108510b20>, '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.fEpmAsTJQr/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.uitDbdXuIn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 09:33:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:33:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:33:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fEpmAsTJQr/Render', 09:33:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:33:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:33:43 INFO - 'HOME': '/Users/cltbld', 09:33:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:33:43 INFO - 'LOGNAME': 'cltbld', 09:33:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:43 INFO - 'MOZ_NO_REMOTE': '1', 09:33:43 INFO - 'NO_EM_RESTART': '1', 09:33:43 INFO - 'PAGER': '/bin/cat', 09:33:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:33:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:43 INFO - 'PWD': '/builds/slave/test', 09:33:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:33:43 INFO - 'SHELL': '/bin/bash', 09:33:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uitDbdXuIn/Listeners', 09:33:43 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 09:33:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:33:43 INFO - 'USER': 'cltbld', 09:33:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:33:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:33:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:43 INFO - 'XPC_FLAGS': '0x0', 09:33:43 INFO - 'XPC_SERVICE_NAME': '0', 09:33:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:33:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:43 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 09:33:43 INFO - Cleaning up... 09:33:43 INFO - Return code: 0 09:33:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:33:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108704490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10867a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80c0c56ea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108518d30>, '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 0x10833edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108510b20>, '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.fEpmAsTJQr/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.uitDbdXuIn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 09:33:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:33:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:33:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fEpmAsTJQr/Render', 09:33:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:33:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:33:43 INFO - 'HOME': '/Users/cltbld', 09:33:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:33:43 INFO - 'LOGNAME': 'cltbld', 09:33:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:43 INFO - 'MOZ_NO_REMOTE': '1', 09:33:43 INFO - 'NO_EM_RESTART': '1', 09:33:43 INFO - 'PAGER': '/bin/cat', 09:33:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:33:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:43 INFO - 'PWD': '/builds/slave/test', 09:33:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:33:43 INFO - 'SHELL': '/bin/bash', 09:33:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uitDbdXuIn/Listeners', 09:33:43 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 09:33:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:33:43 INFO - 'USER': 'cltbld', 09:33:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:33:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:33:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:43 INFO - 'XPC_FLAGS': '0x0', 09:33:43 INFO - 'XPC_SERVICE_NAME': '0', 09:33:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:33:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:43 INFO - Downloading/unpacking psutil>=3.1.1 09:33: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 09:33: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 09:33: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 09:33: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 09:33: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 09:33: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 09:33:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:33:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:33:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:33:46 INFO - Installing collected packages: psutil 09:33:46 INFO - Running setup.py install for psutil 09:33:46 INFO - building 'psutil._psutil_osx' extension 09:33: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 09:33: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 09:33: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 09:33: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 09:33:47 INFO - building 'psutil._psutil_posix' extension 09:33: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 09:33:47 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:33:47 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:33:47 INFO - ^ 09:33:47 INFO - 1 warning generated. 09:33: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 09:33:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:33:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:33:48 INFO - Successfully installed psutil 09:33:48 INFO - Cleaning up... 09:33:48 INFO - Return code: 0 09:33:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:33:48 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')]} 09:33:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:48 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')]} 09:33:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:48 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 0x108704490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10867a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80c0c56ea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108518d30>, '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 0x10833edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108510b20>, '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.fEpmAsTJQr/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.uitDbdXuIn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 09:33:48 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 09:33:48 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 09:33:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fEpmAsTJQr/Render', 09:33:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:33:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:33:48 INFO - 'HOME': '/Users/cltbld', 09:33:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:33:48 INFO - 'LOGNAME': 'cltbld', 09:33:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:48 INFO - 'MOZ_NO_REMOTE': '1', 09:33:48 INFO - 'NO_EM_RESTART': '1', 09:33:48 INFO - 'PAGER': '/bin/cat', 09:33:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:33:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:48 INFO - 'PWD': '/builds/slave/test', 09:33:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:33:48 INFO - 'SHELL': '/bin/bash', 09:33:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uitDbdXuIn/Listeners', 09:33:48 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 09:33:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:33:48 INFO - 'USER': 'cltbld', 09:33:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:33:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:33:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:48 INFO - 'XPC_FLAGS': '0x0', 09:33:48 INFO - 'XPC_SERVICE_NAME': '0', 09:33:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:33:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:33: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 09:33: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 09:33: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 09:33: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 09:33: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 09:33: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 09:33:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:33:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:33:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:33:50 INFO - Installing collected packages: mozsystemmonitor 09:33:50 INFO - Running setup.py install for mozsystemmonitor 09:33:51 INFO - Successfully installed mozsystemmonitor 09:33:51 INFO - Cleaning up... 09:33:51 INFO - Return code: 0 09:33:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:33:51 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')]} 09:33:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:51 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')]} 09:33:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:51 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 0x108704490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10867a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80c0c56ea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108518d30>, '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 0x10833edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108510b20>, '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.fEpmAsTJQr/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.uitDbdXuIn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 09:33:51 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 09:33:51 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 09:33:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fEpmAsTJQr/Render', 09:33:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:33:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:33:51 INFO - 'HOME': '/Users/cltbld', 09:33:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:33:51 INFO - 'LOGNAME': 'cltbld', 09:33:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:51 INFO - 'MOZ_NO_REMOTE': '1', 09:33:51 INFO - 'NO_EM_RESTART': '1', 09:33:51 INFO - 'PAGER': '/bin/cat', 09:33:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:33:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:51 INFO - 'PWD': '/builds/slave/test', 09:33:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:33:51 INFO - 'SHELL': '/bin/bash', 09:33:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uitDbdXuIn/Listeners', 09:33:51 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 09:33:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:33:51 INFO - 'USER': 'cltbld', 09:33:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:33:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:33:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:51 INFO - 'XPC_FLAGS': '0x0', 09:33:51 INFO - 'XPC_SERVICE_NAME': '0', 09:33:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:33:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:51 INFO - Downloading/unpacking jsonschema==2.5.1 09:33: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 09:33: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 09:33: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 09:33: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 09:33: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 09:33: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 09:33:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:33:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:33: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 09:33: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 09:33: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 09:33: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 09:33: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 09:33: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 09:33:54 INFO - Downloading functools32-3.2.3-2.tar.gz 09:33:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:33:54 INFO - warning: no files found matching '*.txt' 09:33:54 INFO - no previously-included directories found matching 'build' 09:33:54 INFO - no previously-included directories found matching 'dist' 09:33:54 INFO - no previously-included directories found matching '.git*' 09:33:54 INFO - Installing collected packages: jsonschema, functools32 09:33:54 INFO - Running setup.py install for functools32 09:33:54 INFO - warning: no files found matching '*.txt' 09:33:54 INFO - no previously-included directories found matching 'build' 09:33:54 INFO - no previously-included directories found matching 'dist' 09:33:54 INFO - no previously-included directories found matching '.git*' 09:33:54 INFO - Successfully installed jsonschema functools32 09:33:54 INFO - Cleaning up... 09:33:54 INFO - Return code: 0 09:33:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:33: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')]} 09:33:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33: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')]} 09:33:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33: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 0x108704490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10867a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80c0c56ea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108518d30>, '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 0x10833edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108510b20>, '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.fEpmAsTJQr/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.uitDbdXuIn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 09:33: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 09:33: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 09:33:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fEpmAsTJQr/Render', 09:33:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:33:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:33:54 INFO - 'HOME': '/Users/cltbld', 09:33:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:33:54 INFO - 'LOGNAME': 'cltbld', 09:33:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:54 INFO - 'MOZ_NO_REMOTE': '1', 09:33:54 INFO - 'NO_EM_RESTART': '1', 09:33:54 INFO - 'PAGER': '/bin/cat', 09:33:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:33:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:54 INFO - 'PWD': '/builds/slave/test', 09:33:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:33:54 INFO - 'SHELL': '/bin/bash', 09:33:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uitDbdXuIn/Listeners', 09:33:54 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 09:33:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:33:54 INFO - 'USER': 'cltbld', 09:33:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:33:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:33:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:54 INFO - 'XPC_FLAGS': '0x0', 09:33:54 INFO - 'XPC_SERVICE_NAME': '0', 09:33:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:33:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:33:54 INFO - Cleaning up... 09:33:55 INFO - Return code: 0 09:33:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:33:55 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')]} 09:33:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:55 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')]} 09:33:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:55 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 0x108704490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10867a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80c0c56ea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108518d30>, '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 0x10833edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108510b20>, '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.fEpmAsTJQr/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.uitDbdXuIn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 09:33:55 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 09:33:55 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 09:33:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fEpmAsTJQr/Render', 09:33:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:33:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:33:55 INFO - 'HOME': '/Users/cltbld', 09:33:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:33:55 INFO - 'LOGNAME': 'cltbld', 09:33:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:55 INFO - 'MOZ_NO_REMOTE': '1', 09:33:55 INFO - 'NO_EM_RESTART': '1', 09:33:55 INFO - 'PAGER': '/bin/cat', 09:33:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:33:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:55 INFO - 'PWD': '/builds/slave/test', 09:33:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:33:55 INFO - 'SHELL': '/bin/bash', 09:33:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uitDbdXuIn/Listeners', 09:33:55 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 09:33:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:33:55 INFO - 'USER': 'cltbld', 09:33:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:33:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:33:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:55 INFO - 'XPC_FLAGS': '0x0', 09:33:55 INFO - 'XPC_SERVICE_NAME': '0', 09:33:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:33:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:55 INFO - Downloading/unpacking blobuploader==1.2.4 09:33: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 09:33: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 09:33: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 09:33: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 09:33: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 09:33: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 09:33:57 INFO - Downloading blobuploader-1.2.4.tar.gz 09:33:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:33:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:33: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 09:33: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 09:33: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 09:33: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 09:33: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 09:33: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 09:33:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:33:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:33: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 09:33: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 09:33: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 09:33: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 09:33: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 09:33: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 09:33:58 INFO - Downloading docopt-0.6.1.tar.gz 09:33:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:33:59 INFO - Installing collected packages: blobuploader, requests, docopt 09:33:59 INFO - Running setup.py install for blobuploader 09:33:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:33:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:33:59 INFO - Running setup.py install for requests 09:33:59 INFO - Running setup.py install for docopt 09:33:59 INFO - Successfully installed blobuploader requests docopt 09:33:59 INFO - Cleaning up... 09:33:59 INFO - Return code: 0 09:33:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:33:59 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')]} 09:33:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:59 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')]} 09:33:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:59 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 0x108704490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10867a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80c0c56ea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108518d30>, '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 0x10833edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108510b20>, '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.fEpmAsTJQr/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.uitDbdXuIn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 09:33:59 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 09:33:59 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 09:33:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fEpmAsTJQr/Render', 09:33:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:33:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:33:59 INFO - 'HOME': '/Users/cltbld', 09:33:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:33:59 INFO - 'LOGNAME': 'cltbld', 09:33:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:59 INFO - 'MOZ_NO_REMOTE': '1', 09:33:59 INFO - 'NO_EM_RESTART': '1', 09:33:59 INFO - 'PAGER': '/bin/cat', 09:33:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:33:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:59 INFO - 'PWD': '/builds/slave/test', 09:33:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:33:59 INFO - 'SHELL': '/bin/bash', 09:33:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uitDbdXuIn/Listeners', 09:33:59 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 09:33:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:33:59 INFO - 'USER': 'cltbld', 09:33:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:33:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:33:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:59 INFO - 'XPC_FLAGS': '0x0', 09:33:59 INFO - 'XPC_SERVICE_NAME': '0', 09:33:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:34:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:34:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:34:00 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-kFIOvO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:34:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:34:00 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-qsJ144-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:34:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:34:00 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-VWgCxP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:34:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:34:00 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-ywFbUr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:34:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:34:00 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-AJNd76-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:34:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:34:00 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-XiqvOA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:34:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:34:00 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-gm3UOF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:34:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:34:00 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-08zqNH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:34:01 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-kfsBeW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:34:01 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-iR7bqD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:34:01 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-nwXHss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:34:01 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-Af2lk3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:34:01 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-CSpR7I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:34:01 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-6yYvde-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:34:01 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-kUvz1G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:34:01 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-vHA4uU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:34:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:34:01 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-bKzLFx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:34:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:34:02 INFO - Running setup.py install for manifestparser 09:34:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:34:02 INFO - Running setup.py install for mozcrash 09:34:02 INFO - Running setup.py install for mozdebug 09:34:02 INFO - Running setup.py install for mozdevice 09:34:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:34:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:34:02 INFO - Running setup.py install for mozfile 09:34:02 INFO - Running setup.py install for mozhttpd 09:34:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:34:02 INFO - Running setup.py install for mozinfo 09:34:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:34:03 INFO - Running setup.py install for mozInstall 09:34:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:34:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:34:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:34:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:34:03 INFO - Running setup.py install for mozleak 09:34:03 INFO - Running setup.py install for mozlog 09:34:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:34:03 INFO - Running setup.py install for moznetwork 09:34:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:34:03 INFO - Running setup.py install for mozprocess 09:34:03 INFO - Running setup.py install for mozprofile 09:34:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:34:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:34:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:34:03 INFO - Running setup.py install for mozrunner 09:34:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:34:04 INFO - Running setup.py install for mozscreenshot 09:34:04 INFO - Running setup.py install for moztest 09:34:04 INFO - Running setup.py install for mozversion 09:34:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:34:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:34:04 INFO - Cleaning up... 09:34:04 INFO - Return code: 0 09:34:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:34: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')]} 09:34:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:34:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:34: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')]} 09:34:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:34:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:34: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 0x108704490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10867a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80c0c56ea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108518d30>, '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 0x10833edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108510b20>, '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.fEpmAsTJQr/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.uitDbdXuIn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 09:34: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 09:34: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 09:34:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fEpmAsTJQr/Render', 09:34:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:34:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:34:04 INFO - 'HOME': '/Users/cltbld', 09:34:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:34:04 INFO - 'LOGNAME': 'cltbld', 09:34:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:34:04 INFO - 'MOZ_NO_REMOTE': '1', 09:34:04 INFO - 'NO_EM_RESTART': '1', 09:34:04 INFO - 'PAGER': '/bin/cat', 09:34:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:34:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:34:04 INFO - 'PWD': '/builds/slave/test', 09:34:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:34:04 INFO - 'SHELL': '/bin/bash', 09:34:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uitDbdXuIn/Listeners', 09:34:04 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 09:34:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:34:04 INFO - 'USER': 'cltbld', 09:34:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:34:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:34:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:34:04 INFO - 'XPC_FLAGS': '0x0', 09:34:04 INFO - 'XPC_SERVICE_NAME': '0', 09:34:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:34:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:34:04 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-_VdCjp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:34:04 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)) 09:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:34:04 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-MbbwqC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:34:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:34:05 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-d4HL_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:34: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)) 09:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:34:05 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-o_il46-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:34:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:34:05 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-hJO38J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:34: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)) 09:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:34:05 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-yh_Wgr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:34: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)) 09:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:34:05 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-Usci6m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:34: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)) 09:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:34:05 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-NjEpws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:34: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)) 09:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:34:05 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-Zs9rSG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:34: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)) 09:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:34:05 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-tuF_Kq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:34:05 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)) 09:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:34:05 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-UTfprz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:34: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)) 09:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:34:06 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-Ov5Lol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:34:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:34:06 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-tysjW0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:34: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)) 09:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:34:06 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-5LR2qJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:34:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:34:06 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-Q0GBh1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:34: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)) 09:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:34:06 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-T_B_8l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:34:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:34:06 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-vfyZow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:34: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)) 09:34: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==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:34: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==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:34: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)) 09:34: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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:34: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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:34:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:34: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 09:34: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 09:34: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 09:34: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 09:34: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 09:34: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 09:34:09 INFO - Downloading blessings-1.6.tar.gz 09:34:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:34:09 INFO - Installing collected packages: blessings 09:34:09 INFO - Running setup.py install for blessings 09:34:09 INFO - Successfully installed blessings 09:34:09 INFO - Cleaning up... 09:34:09 INFO - Return code: 0 09:34:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:34:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:34:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:34:09 INFO - Reading from file tmpfile_stdout 09:34:09 INFO - Current package versions: 09:34:09 INFO - blessings == 1.6 09:34:09 INFO - blobuploader == 1.2.4 09:34:09 INFO - docopt == 0.6.1 09:34:09 INFO - functools32 == 3.2.3-2 09:34:09 INFO - jsonschema == 2.5.1 09:34:09 INFO - manifestparser == 1.1 09:34:09 INFO - mozInstall == 1.12 09:34:09 INFO - mozcrash == 0.17 09:34:09 INFO - mozdebug == 0.1 09:34:09 INFO - mozdevice == 0.48 09:34:09 INFO - mozfile == 1.2 09:34:09 INFO - mozhttpd == 0.7 09:34:09 INFO - mozinfo == 0.9 09:34:09 INFO - mozleak == 0.1 09:34:09 INFO - mozlog == 3.4 09:34:09 INFO - moznetwork == 0.27 09:34:09 INFO - mozprocess == 0.23 09:34:09 INFO - mozprofile == 0.28 09:34:09 INFO - mozrunner == 6.12 09:34:09 INFO - mozscreenshot == 0.1 09:34:09 INFO - mozsystemmonitor == 0.3 09:34:09 INFO - moztest == 0.7 09:34:09 INFO - mozversion == 1.4 09:34:09 INFO - psutil == 3.1.1 09:34:09 INFO - requests == 1.2.3 09:34:09 INFO - wsgiref == 0.1.2 09:34:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:34:09 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')]} 09:34:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:34:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:34: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')]} 09:34:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:34:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:34: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 0x108704490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10867a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80c0c56ea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108518d30>, '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 0x10833edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108510b20>, '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.fEpmAsTJQr/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.uitDbdXuIn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 09:34: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 09:34: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 09:34:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fEpmAsTJQr/Render', 09:34:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:34:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:34:10 INFO - 'HOME': '/Users/cltbld', 09:34:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:34:10 INFO - 'LOGNAME': 'cltbld', 09:34:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:34:10 INFO - 'MOZ_NO_REMOTE': '1', 09:34:10 INFO - 'NO_EM_RESTART': '1', 09:34:10 INFO - 'PAGER': '/bin/cat', 09:34:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:34:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:34:10 INFO - 'PWD': '/builds/slave/test', 09:34:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:34:10 INFO - 'SHELL': '/bin/bash', 09:34:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uitDbdXuIn/Listeners', 09:34:10 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 09:34:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:34:10 INFO - 'USER': 'cltbld', 09:34:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:34:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:34:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:34:10 INFO - 'XPC_FLAGS': '0x0', 09:34:10 INFO - 'XPC_SERVICE_NAME': '0', 09:34:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:34:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:34: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)) 09:34: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)) 09:34: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)) 09:34: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)) 09:34: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)) 09:34: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)) 09:34: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)) 09:34: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)) 09:34: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)) 09:34: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)) 09:34: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)) 09:34:10 INFO - Cleaning up... 09:34:10 INFO - Return code: 0 09:34:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:34: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')]} 09:34:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:34:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:34: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')]} 09:34:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:34:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:34: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 0x108704490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10867a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80c0c56ea0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108518d30>, '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 0x10833edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108510b20>, '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.fEpmAsTJQr/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.uitDbdXuIn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 09:34: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 09:34: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 09:34:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fEpmAsTJQr/Render', 09:34:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:34:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:34:10 INFO - 'HOME': '/Users/cltbld', 09:34:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:34:10 INFO - 'LOGNAME': 'cltbld', 09:34:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:34:10 INFO - 'MOZ_NO_REMOTE': '1', 09:34:10 INFO - 'NO_EM_RESTART': '1', 09:34:10 INFO - 'PAGER': '/bin/cat', 09:34:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:34:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:34:10 INFO - 'PWD': '/builds/slave/test', 09:34:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:34:10 INFO - 'SHELL': '/bin/bash', 09:34:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uitDbdXuIn/Listeners', 09:34:10 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 09:34:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:34:10 INFO - 'USER': 'cltbld', 09:34:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:34:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:34:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:34:10 INFO - 'XPC_FLAGS': '0x0', 09:34:10 INFO - 'XPC_SERVICE_NAME': '0', 09:34:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:34:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:34:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:34:10 INFO - Cleaning up... 09:34:10 INFO - Return code: 0 09:34:10 INFO - Running post-action listener: _resource_record_post_action 09:34:10 INFO - Running post-action listener: _start_resource_monitoring 09:34:10 INFO - Starting resource monitoring. 09:34:10 INFO - [mozharness: 2016-09-26 16:34:10.818996Z] Finished create-virtualenv step (success) 09:34:10 INFO - [mozharness: 2016-09-26 16:34:10.819955Z] Running install step. 09:34:10 INFO - Running pre-action listener: _resource_record_pre_action 09:34:10 INFO - Running main action method: install 09:34:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:34:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:34:11 INFO - Reading from file tmpfile_stdout 09:34:11 INFO - Detecting whether we're running mozinstall >=1.0... 09:34:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:34:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:34:11 INFO - Reading from file tmpfile_stdout 09:34:11 INFO - Output received: 09:34:11 INFO - Usage: mozinstall [options] installer 09:34:11 INFO - Options: 09:34:11 INFO - -h, --help show this help message and exit 09:34:11 INFO - -d DEST, --destination=DEST 09:34:11 INFO - Directory to install application into. [default: 09:34:11 INFO - "/builds/slave/test"] 09:34:11 INFO - --app=APP Application being installed. [default: firefox] 09:34:11 INFO - mkdir: /builds/slave/test/build/application 09:34:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:34:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 09:34:45 INFO - Reading from file tmpfile_stdout 09:34:45 INFO - Output received: 09:34:45 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:34:45 INFO - Running post-action listener: _resource_record_post_action 09:34:45 INFO - [mozharness: 2016-09-26 16:34:45.296329Z] Finished install step (success) 09:34:45 INFO - [mozharness: 2016-09-26 16:34:45.296489Z] Running run-tests step. 09:34:45 INFO - Running pre-action listener: _resource_record_pre_action 09:34:45 INFO - Running main action method: run_tests 09:34:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:34:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:34:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:34:45 INFO - 2016-09-26 09:34:45.311 screenresolution[1642:7541] starting screenresolution argv=screenresolution get 09:34:45 INFO - 2016-09-26 09:34:45.314 screenresolution[1642:7541] Display 0: 1600x1200x32@60 09:34:45 INFO - 2016-09-26 09:34:45.320 screenresolution[1643:7545] starting screenresolution argv=screenresolution list 09:34:45 INFO - Available Modes on Display 0 09:34:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:34:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:34:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:34:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:34:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:34:45 INFO - Intel Iris: 09:34:45 INFO - Chipset Model: Intel Iris 09:34:45 INFO - Type: GPU 09:34:45 INFO - Bus: Built-In 09:34:45 INFO - VRAM (Dynamic, Max): 1536 MB 09:34:45 INFO - Vendor: Intel (0x8086) 09:34:45 INFO - Device ID: 0x0a2e 09:34:45 INFO - Revision ID: 0x0009 09:34:45 INFO - Displays: 09:34:45 INFO - Display: 09:34:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:34:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:34:45 INFO - Display Serial Number: 1600x1200 60 09:34:45 INFO - Main Display: Yes 09:34:45 INFO - Mirror: Off 09:34:45 INFO - Online: Yes 09:34:45 INFO - Rotation: Supported 09:34:45 INFO - Return code: 0 09:34:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:34:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:34:45 INFO - Python 2.7.3 09:34:45 INFO - Return code: 0 09:34:45 INFO - grabbing minidump binary from tooltool 09:34:45 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')]} 09:34:45 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 0x108518d30>, '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 0x10833edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108510b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:34:45 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 09:34:45 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 09:34:45 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 09:34:45 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:34:45 INFO - Return code: 0 09:34:45 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:34:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:34:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:34:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:34:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:34:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M1sX-InQRyWL7FMjniO_HQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0153', '--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 09:34:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/M1sX-InQRyWL7FMjniO_HQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0153 --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 09:34:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fEpmAsTJQr/Render', 09:34:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:34:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:34:45 INFO - 'HOME': '/Users/cltbld', 09:34:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:34:45 INFO - 'LOGNAME': 'cltbld', 09:34:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:34:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:34:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:34:45 INFO - 'MOZ_NO_REMOTE': '1', 09:34:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:34:45 INFO - 'NO_EM_RESTART': '1', 09:34:45 INFO - 'PAGER': '/bin/cat', 09:34:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:34:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:34:45 INFO - 'PWD': '/builds/slave/test', 09:34:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:34:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:34:45 INFO - 'SHELL': '/bin/bash', 09:34:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uitDbdXuIn/Listeners', 09:34:45 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 09:34:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:34:45 INFO - 'USER': 'cltbld', 09:34:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:34:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:34:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:34:45 INFO - 'XPC_FLAGS': '0x0', 09:34:45 INFO - 'XPC_SERVICE_NAME': '0', 09:34:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:34:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M1sX-InQRyWL7FMjniO_HQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0153', '--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 09:34:45 INFO - mozversion application_buildid: 20160926071051 09:34:45 INFO - mozversion application_changeset: ee066384095172f059aab32ed55839e66372cce5 09:34:45 INFO - mozversion application_display_name: Nightly 09:34:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:34:45 INFO - mozversion application_name: Firefox 09:34:45 INFO - mozversion application_remotingname: firefox 09:34:45 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 09:34:45 INFO - mozversion application_vendor: Mozilla 09:34:45 INFO - mozversion application_version: 52.0a1 09:34:45 INFO - mozversion platform_buildid: 20160926071051 09:34:45 INFO - mozversion platform_changeset: ee066384095172f059aab32ed55839e66372cce5 09:34:45 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 09:34:45 INFO - mozversion platform_version: 52.0a1 09:34:45 INFO - using testdate: 1474907685 09:34:45 INFO - actual date: 1474907685 09:34:45 INFO - starting webserver on 'localhost:49276' 09:34:45 INFO - SUITE-START | Running 2 tests 09:34:45 INFO - TEST-START | dromaeo_css 09:34:45 INFO - operating with platform_type : mac_ 09:34:45 INFO - Initialising browser for dromaeo_css test... 09:34:45 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/tmpunH9Xz/profile http://localhost:49276/getInfo.html) 09:34:48 INFO - PROCESS | 1653 | 2016-09-26 09:34:48.540 plugin-container[1655:7716] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x893b, name = 'com.apple.tsm.portname' 09:34:48 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:34:48 INFO - PROCESS | 1653 | 2016-09-26 09:34:48.543 plugin-container[1655:7716] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4b07, name = 'com.apple.CFPasteboardClient' 09:34:48 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:34:48 INFO - PROCESS | 1653 | 2016-09-26 09:34:48.543 plugin-container[1655:7716] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:34:48 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 09:34:48 INFO - PROCESS | 1653 | colorDepth:24 09:34:48 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 09:34:48 INFO - PROCESS | 1653 | __metrics 09:34:48 ERROR - PROCESS | 1653 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 09:34:49 INFO - TEST-INFO | 1653: exit 0 09:34:49 INFO - Browser initialized. 09:34:49 INFO - Running cycle 1/1 for dromaeo_css test... 09:34:49 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/tmpunH9Xz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:34:52 INFO - PROCESS | 1656 | 2016-09-26 09:34:52.031 plugin-container[1657:7836] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x872f, name = 'com.apple.tsm.portname' 09:34:52 INFO - PROCESS | 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:34:52 INFO - PROCESS | 1656 | 2016-09-26 09:34:52.034 plugin-container[1657:7836] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d03, name = 'com.apple.CFPasteboardClient' 09:34:52 INFO - PROCESS | 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:34:52 INFO - PROCESS | 1656 | 2016-09-26 09:34:52.034 plugin-container[1657:7836] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:35:01 INFO - PROCESS | 1656 | RSS: Main: 239587328 09:35:01 INFO - PROCESS | 1656 | 09:35:51 INFO - PROCESS | 1656 | 1474907751235 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 09:38:03 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49276/tests/dromaeo/cssquery-ext.html) 09:38:04 INFO - PROCESS | 1656 | RSS: Main: 253001728 09:38:04 INFO - PROCESS | 1656 | 09:41:06 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-ext.html (next: http://localhost:49276/tests/dromaeo/cssquery-jquery.html) 09:41:07 INFO - PROCESS | 1656 | RSS: Main: 265191424 09:41:07 INFO - PROCESS | 1656 | 09:44:09 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49276/tests/dromaeo/cssquery-mootools.html) 09:44:10 INFO - PROCESS | 1656 | RSS: Main: 269627392 09:44:10 INFO - PROCESS | 1656 | 09:47:11 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49276/tests/dromaeo/cssquery-prototype.html) 09:47:12 INFO - PROCESS | 1656 | RSS: Main: 270417920 09:47:12 INFO - PROCESS | 1656 | 09:50:15 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49276/tests/dromaeo/cssquery-yui.html) 09:50:16 INFO - PROCESS | 1656 | RSS: Main: 276004864 09:50:16 INFO - PROCESS | 1656 | 09:53:18 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-yui.html (next: http://localhost:49276/tests/dromaeo/cssquery-dojo.html) 09:53:18 INFO - PROCESS | 1656 | RSS: Main: 278507520 09:53:18 INFO - PROCESS | 1656 | 09:53:18 INFO - PROCESS | 1656 | __start_tp_report 09:53:18 INFO - PROCESS | 1656 | _x_x_mozilla_page_load 09:53:18 INFO - PROCESS | 1656 | _x_x_mozilla_page_load_details 09:53:18 INFO - PROCESS | 1656 | |i|pagename|runs| 09:53:18 INFO - PROCESS | 1656 | |0;dojo.html;3321.6512266212044;3391.643877392872;3432.3478539077587;3433.124553238924;3438.948415773763;5341.252224688542;5576.856744367395;5714.285714285715;5773.162891380747;5782.710864456782;4501.819927202908;5676.262085928824;5730.79942202023;5791.623544469607;5837.211976383187;5201.869953251161;5221.738913054351;5281.788728450857;5325.4940780625775;5362.865928351784;5263.1578947368425;5281.996420680078;5314.787408503656;5357.330333708267;5365.597580181482;5162.638615296931;5170.043541944752;5215.269862219292;5262.868428289324;5286.9690410370185;5205.869853253661;5211.478852114796;5228.398734145584;5315;5321.228421878806;5229.633925625208;5242.606804489678;5248.370195576517;5256.684598924076;5341.2255222992835;5585.553155747531;5674.120511320752;5765.855853603652;5785.797497087582;5834.649921004753;6215.720292586844;6235.407636274546;6305.936940630627;6309.305976342599;6309.400606942379;6202.782902598433;6292.33930437302;6302.9369706302805;6305.148804911324;6328.8101356958905;5711.600187986801;5797.768089276382;5825.88348233033;5852.707364631751;5864.1203819427;6289.7484100636375;6366.26787919386;6389.904151437732;6407.935920640827;6434.131392261985;6196.318404975449;6208.627482350983;6215.409536094064;6235.282942461584;6247.843803904939;6118.95422233728;6197.4732147767945;6309.337519560472;6310.968445157837;6314;4790.880227994258;6195.504359651217;6261.843453913689;6265.749370025239;6272.372762723691;6221.906671399933;6223.906641400383;6265.091561723616;6278.529110316745;6312.116303717483;3953.5058117735284;4126.7523948563185;4364.367166760802;4932.53140951609;4943.505649435027;4415.161119387306;4424.446944131983;4451.86644400662;4469.08383781324;4577.496475387705;5834.095715164156;5881.647101173943;5883.264591926009;5897.76408943646;5922.230110085661;6152.78465253714;6307.05394190875;6313.116163737081;6316.178896743394;6316.557840951089;4866.46468888422;5795.304563452329;5846.298444186725;5919.082542205879;6000.129981152796;5443.972780136074;5482.396936337;5483.4516548344845;5488.725563721798;5495.560355171577;6321.905171422524;6405.775797847053;6411.6153030818305;6417.454516366161;6420.6789660517725;6196.411340922605;6228.159198508143;6238.937610624017;6248.593841400295;6333.936660633335;6420;6432.517561183024;6448.484121270193;6451.3548645135115;6467.417932386108;6114.6942652868065;6162.613411982447;6258.655773932477;6291.653959032297;6298.02380631003;6237.812865614039;6269.279032911274;6290.528210384148;6298.84252893663;6310.968445157745;4902.828401005948;6066.423689749467;6168.599041062316;6195.4424101831055;6198.2252218472695;6159.322474527708;6191.288001879841;6199.132121503083;6203.906941395792;6209.161763161916;5852.239208902985;5900.11498275245;5951.345352011189;5996.280446346466;6071.362506936708;6176.382361763787;6177.2587289525545;6195.566310358232;6202.534809889186;6211.2857021441305;6069.635821850703;6073.848153796191;6086.817395478142;6113.050656958906;6113.301452621278 09:53:18 INFO - PROCESS | 1656 | |1;ext.html;472.22319284776523;485.64790526868023;501.6488458079345;517.4049842680918;518.9532942035221;32412.837935810316;40380.78857634272;40407.787766366986;42531.787341063326;42585.14829703412;40735.79632101835;41120.79439602805;41139;41201.381979270336;41306.586934130646;8055.9194408055755;8343.707970221043;9890.258230632695;9923.255755818307;9935.254855885802;9772.951135244313;9783.412995220275;9870.062344077302;9873.210143188528;9883.950580247089;9885.01149885013;9886.159676427513;9909.95045024774;9918.702438926808;9945.055219754111;8236.176382361746;9748.658796942143;9906.108450239513;9913.206943444507;9948.403095814201;8361.372897032747;9742.464164470952;9771.12059914611;9846.704598862045;9851.310408271424;39606;39947.20105597901;39970;39984.40101393429;40088.799556002035;3115.766317526172;3265.4775235962134;3375.6793104655017;3382.543356646846;3440.896773096811;30685.846570767226;30879.536806947915;31004.68995310063;31757.8412107938;32871.83564082188;3209.5667084943702;3211.2614098757185;3233.7413006959623;3331.68349006844;3349.4592487455798;506875;507142;515961;516693;518032;34208;58278.125828112614;66457.66771166114;66487.66756166189;66591.66704166448;34585.65414345825;35551.64448355535;35799.4630080549;35840.28319433649;35870.8206458966;14688.779668304984;14828.555143345717;14869.628259293388;14870.330835112445;14874.851251487347;12404.19372740787;12546.435410406553;12633.810492842615;12638.368081595883;12717.809232861515;7816.41376896735;7927.088384835818;8024.598770061473;8043.235892590312;8071.152528984489;2973.3012742005612;3394.6775056369606;3396.2018925552475;3414.4195486767308;3420.247545539977;763.6220071064747;813.556611646654;899.8560230363111;969.4038166527675;1140.589387820384;25019.499610007697;28554.714452855205;29444.852775735984;29994.25014374658;30104;1054.288355360129;1077.8814330423647;1082.242430298794;1094.179365475893;1105.90599799018;13356.866431335757;15224.771628425582;15257.476782426042;15269.541913742605;15306.693866122838;672960;679019.258844471;682390;682392;683354;49919;50946;51041.74479127581;51520.48479515157;51716.74141629343;1343.7043850352907;1385.9792103118461;1405.1358414575168;1405.7961595568586;1410.2666613360996;28032.439351212455;28757.712422875502;28940.98706545261;29461.410771784875;29474.705252947195;45919.77040114778;46875.76562117304;46910.82722931817;46945.18328900277;47019.76490117527;621329;623916;625608;626795;627830;26829.329266768487;26941.922323106857;27044.91820327165;27125.72874271232;27176.456470870868;44729.88175295643;44962.77518612386;45153.774231128635;46053.76973115113;46488;33209.33581328408;34195.97412077642;38088.42867357047;38396;38549.229015418976;30992.845035774677;37320.44019339658;37664.87005389843;38570.80714596409;38613.03467413225;36855.81572092122;37146.44280335743;38268.234635307694;38438;39555.80222098871;29957;33907.321853563284;34038.319233615686;34182.53079507267;34679.13302167365;24314.51370972606;24327.635085474085;24649.87675061613;25200.621990670523;25484.617730733684 09:53:18 INFO - PROCESS | 1656 | |2;jquery.html;361.55889814426405;372.2982178593351;373.4118762948357;377.2135098320003;394.97827619480915;16342.673146537061;19580.398666128327;20227.696584551242;20630;21184.682229766546;20238.66634684574;20442.2845200418;20687.896560517176;20769.792302076974;21216;4641.698289611181;5728.9974254505505;5956.34480207178;6059.3637668044885;6137.355577664325;5176.818811341604;5997.280326360821;6050.606710563821;6094.756209751605;6105.511559075263;4709.7174169549935;4753.976230118845;5283.524482796547;6500.642464664442;6718.160229971254;6184.103305020747;6644.169478815148;6699.296573859748;6740.191177058759;6761.290064543201;5077.695338279715;5425.643589102724;5869.735861886183;5934.465898069195;5960.761569537257;10227.437490937995;13214.735705285937;18850;25554.361140971625;25596.36009099769;2115.217369573252;2159.7192364992607;2243.1924507177405;2260.3666728261555;2270.94401103486;9876.160526355268;10076.143527800146;10087.34432261908;10429.165666746641;10461.84307235392;1864.5804693943753;1891.4703882912806;1913.6172765446827;1937.1282922684848;1974.1511150205406;127641;128424.35787821094;129225.35387323004;130221;131423;10872.891271087188;11608;11630.476628551736;11637.592684256011;11795.29228246308;14383.424663013571;14478.203698796457;14480.348384322731;14540.563783086523;14541.418343266363;6932.296404402186;8139.267465928095;8364;8368.958155209306;8378.748637540884;7194.316539928698;8128.715494957648;8188.50868947865;8247.752567422987;8396.992360916607;4484;4520.615747661485;4525.321201819687;4557.453105627346;4560.338750881104;1744.9791871755165;1883.8681292309407;1939.224310275901;1945.7956914524054;1961.5880665060213;758.4993904023429;829.9792505187419;833.1626715151234;929.5305870535336;947.772534591693;20388.388348349574;20994.37016889496;21841.126354945623;21879.67180492294;21935.67096493554;871.8125602995386;897.8159477307137;916.4409710076848;928.3455164109287;974.8245315843217;10754.946225268981;11267.774644507228;11381.032612228053;11487;11523.423828808525;579189.8729114316;579759;587554;597821;599459.0054099403;136325;136623;138904;139438.30280848735;142241;880.8416931734748;971.1890571372842;997.1225321716843;1017.531935309751;1021.5709402051008;17758.845675031083;18601.9069904655;19446.708299375237;19517;19517.51206219856;41207.58792412037;51784.74107629438;53886;53999.730001351316;55675.60810979758;55691.721541392035;76460;76867.44467522367;77213.61393192998;80403.59798200971;7870.09493908185;7983.5209887406945;8116.553589552631;8149.307308878811;8222.671093156447;9043.342678520436;11405.688345840003;12743.10798244114;12746.872531274568;13221.272829994443;11107.611233606785;11109.388983605979;11278.210525263154;11386.772264554827;11414.942925285653;9527.237820974167;11142.888571114509;11206.43967801623;11318.717032074264;11694.181407301407;11336.489857956247;11638.941805290919;12027.579034734092;12069.818952715541;12112.576059837864;5399.676019438846;7254;7393.482456228013;8071.959640201761;8310.418270720991;9390.718278451657;11334.149938754792;11683.474243658886;11741.647750567497;11748.765024699629 09:53:18 INFO - PROCESS | 1656 | |3;mootools.html;1499.7300485912535;1538.6845696632188;1745.3367720266297;1806.0788997611214;1862.6833438315484;8126.268635822775;8491.023532293773;8609.870851937218;9203.677871274507;9249.982501924791;8567.65729370826;8964.193222609963;8973.327000474957;8993.325500587465;9040.502772347518;2335.346103091133;2384.046381447426;2387.758365649861;2391.880405979694;2399.7720216579396;2364.0543782487057;2383.618621020637;2407.5425669122897;2409.012304954969;2417.903283868643;2367.3844800351862;2384.6303822907475;2390.5935990881594;2401.3396316013063;2403.351095204294;2330.242671131889;2346.894389752457;2351.670766092748;2354.176038386568;2358.9646155307682;2343.6836027136287;2364.7871691547844;2366.9526609467885;2370.727366352857;2377.037299893546;8895.199432051082;8933.59798809055;9002.954985225031;9005.369624126313;9023.4134781239;5276.12943864262;5395.082835917864;5414.648047876875;5435.891282174334;5443.1563107717975;3613.385724426854;3632.473291372736;3665.303592317451;3675.3016926783826;3686.7787932724123;921.8571121476182;1068.476446541197;1088.1947358954317;1093.6937657455846;1095.802755504017;9974.85037724442;10855.805861355244;10914.508847101899;11037.061849742782;11887.227330223508;3818.491695780151;4170.311898536768;4616.838410655611;4807.591354734816;4858.149823780895;8997.595108220146;9923;10066.245031622657;10080.59677612902;10184.6435374763;4518.412606361152;5363;5371.274877891513;5396.784128634889;5404.270423492778;4331.068820203608;4524.796384162721;4735.928961065587;4926.950730492721;4962.528559786814;3407.5570175877474;3875.6318149775725;3914.9021274467796;3980.3233450313514;4020.7788571628257;1062.2511129653576;1273.4333221716247;1276.1003492537739;1280.2382582363664;1286.1897004886862;833.6165363932538;908.8500397434349;913.57975331347;929.3494553812224;942.4593322342918;4608.354830323758;5857.179994800731;6075.665838378932;6134.938650613437;6177.980633195562;371.17598930374527;385.35260761920244;393.42952718558206;400.80961543266716;402.842891272404;3986.720929534905;3994.2610617035944;4025.879223623296;4059.654929330981;4107.178564287155;10625.681229563126;10906.400147991937;11058.778824423627;11125.332480051224;11175.105991520659;10909.618163364245;10943.781124377469;10950.39772812503;11038.392888391216;11085.556577736801;8354.248117669438;8424.326053915673;8428.241458268785;8439.535825529532;8440.704575339834;5180.585553155814;5344.9732751336;5827.708614569339;6088.299845517822;6092.086187071975;10199.439030853375;10286.331388460025;10316.123129534073;10369.377837329785;10403.115735162293;10087.798244034931;10278.229132814919;10331;10555.52500137511;10556.419396933243;6927.792166235021;7154.569086182888;7346.155192152757;7459.328660420588;7617.5048621839405;8445.704400345958;8476.36427267945;8535.847660565743;8631.56842157902;8639.09289524616;7259.2377800332315;7260.782176534501;7469.88795168062;7580.696772129274;7721.420893432903;7372.7050917964825;7466.664000119899;7481.401487881065;7601;7609.124950630749;7106;7208.56748595086;7229.530080544748;7238;7248.60132692707;5014.749262536786;5135.4850319156685;5148.43367229612;5237.633365664519;5254.842354729364;5046.949530504648;5048.495150484922;5094.949050509447;5095.592352611856;5270.077736396192 09:53:18 INFO - PROCESS | 1656 | |4;prototype.html;299.1086562045104;303.6629341431011;310.3869857032361;311.7350252285559;314.3116574701404;4483.618892394143;5430.3755068167175;5518.255035570197;5543.7249432630515;5606.187102870086;5213;5427.2401863739005;5445.809396671108;5460.453954604538;5483.7532311046;3560.430331147017;4177.4569305990335;4196.916061678765;4205.621494065534;4215.957840421603;3429.9142521436916;3857.2092720992127;4191.81136848841;4201.852935147255;4233.8094785734565;3867.091233560111;4105.609967053125;4114.876553703393;4143.316352801784;4156.916861662765;3223.9838800805965;4114.938275925863;4133.565975572582;4151.169766046803;4175.976885663002;3584.318979393907;3591.3356029134693;3592.389293820057;3602.6577475140084;3603.117236277129;4564.566366195239;4951.752412379366;5047.520485553867;5355.7857685692525;5393.379761327458;4184.3932629768815;4384.473863136413;4516.503184649686;4571.519990400993;4787.186178349689;4874.634402419797;5437;5688.293511946399;5849.707514624294;5860.765569377219;3462.6364231755806;3802.448644946495;3865.2804014021444;3899.454076429302;3915.7846318452475;5003.924941125886;6052.21321228242;6140.9385906140815;6144.662043587601;6184.87630247397;3969.047428617169;3988.521377434726;4003.199360127986;4006.959930400717;4037.6971727119994;3744.307303148926;3995.5405128410025;4030.7984600769846;4035.515738111387;4053.452783874139;4698.85903422891;4727.881802954954;4773.355596994361;4779.330893674888;4785.688930219525;4776.928346074812;5204.100503316262;5913.285147307319;5961.463468287875;5972.701364931736;1170.9121815863843;1321.4714114354335;1337.77257866163;1364.3928451838835;1373.2996171952377;781.7101782059533;791.8257983243677;802.3220378779922;859.7420773767844;871.6600525794818;5395.757190926418;5451.291332126877;5453.072977593819;5458.945410545924;5553.888922221614;5476.58925580583;5947.1343626642165;5959.553033522503;5974.193483879708;5989.837063241006;4561.498235194126;5005.024020316004;5120.846374608694;5264.842054738364;5515.779368825282;2954.5125054366217;3118.5342888842206;3171.5084161954933;3180.0936733030976;3205.743540516753;5298.788048478094;6240.65676387794;6333.041848844472;6336.528753786027;6347.873042539123;5387.545362752114;5868.532866783305;5890.734916928663;5988.640681559121;6257.092721555349;5202.869928251824;5361.356637203405;5556.833295001156;6419.935800641933;6472.190976127984;5761.596688231783;6044.697765111815;6118.571699980958;6145.385461453819;6168.845778855564;5633.352164501135;5864.736086876015;6041.879162416815;6081.787137450168;6099.695015249131;5599.684074242631;6359.96820015897;6391.296957334783;6398.904016439664;6449.7420103195345;3377.9190658988887;3537.823108844599;3687.5021872048005;3690.741648084608;3968.543617483911;5895.882082358243;6098.664573448503;6131.264248290234;6144.354842741448;6174.660393678211;5659.179418984142;5739.2252045973255;5813.453793186069;5846.503047241032;5868.5305175585;4822.99845564087;5463.808766693306;5549.611527193219;5623.437656234344;5917.822465326047;4546.930821695409;4634.629229661551;5619.353774315842;5758.3090029196765;5912.674802885883;5854.502367298827;5860.531157507304;5912.556558258234;5961.701914904324;5975.37258587842;4734.810607575659;4879.341288926092;5120.769565369642;5617.74170980822;5830.892130495193 09:53:18 INFO - PROCESS | 1656 | |5;yui.html;651.8500744828689;658.9439897608703;711.9964400177998;724.87314719924;781.4998401023346;14989.700205995874;15908;15963.441279555218;15989.040657560554;16027.439039633615;14167.220802855838;14356.712865742678;14367.856321436782;14386.784198237008;14390.712185756278;665.9800205993804;685.2325395556983;785.4658831994242;826.7974346285168;830.8421399933993;829.1956801902145;840.0717207485732;840.3319361107904;842.296682270305;842.8946381702287;899.3749344205779;902.4314681750488;904.3985749476623;904.4618452021037;904.6471875968377;890.0921060518267;893.0845882970008;894.2667013049302;899.5906862377635;900.3517467423445;561.8370672504968;666.1240468783534;666.340323080152;670.8289386206535;673.9090222819906;14365.712685746332;14628.853711462856;14863.108213507225;14874.479393221294;14903;14426.206558639271;14467.565973020826;14545.92727036358;14550.781738273934;14599.927000365036;9892.30753847231;11684.941575292154;11809.038980666297;11812.822807657893;11928.633811603244;3711.997760604622;3780.243951209769;3789.7915614641183;3794.070452739069;3810.6951443884423;112824;114203;114897.42551287274;114952.27571586432;118933.99999999914;11057.391843448526;11178.44107794607;11227.045701115496;11249.043831274434;11532.731399546043;23017.309480715605;23036.769632303796;23058.538829223657;23072;23171.88414057919;7192.604406757574;7493.737719179802;7989.121196668362;8208.425410221347;8312.33501319893;4405.383246345515;4414.381986521889;4439.467263928284;4484.461864576272;4528.682992190581;3429.6227414984332;3516.771409858351;3547.6452354764833;3578.4274516077303;3579.7494175407473;657.6288438605561;658.4403257231411;661.8246164766341;663.5885750834514;667.6761770541284;559.9608027438122;585.1807469542589;604.145134634496;610.176262046234;634.1977398590786;8897.688580899638;9046.683366082156;9070.455772653662;9143.54282285883;9255.90744092564;493.6248451177131;573.8880918220907;584.1442287049493;637.7066549387241;645.5384400153819;4355.73865568067;4572.4055872736335;4681.9297710534365;4687.414073240845;4711.387519622427;122606;148116.25941870222;150858.24570877076;153067;154420;77386.93969784005;114134;114771.42614287042;122186.3890680541;125126.12310815345;98118;108444;108589;108941.45529272461;109417.45291273652;8960;9128.817423651622;9489.335746497678;9861.840397707792;9940.950295248478;56783;57832.42167578439;58063;58840;59481;72555.27444725485;76041;77779;89170.55414722885;89254.55372723094;8661;10485.52815123306;12603.87396126027;12632.747345052863;13021.414036368576;14468.27658617086;14578.562643120724;14678.412863485768;14798.926005369904;15062.698746024798;10757.246992710436;11814;13406.128601640861;13809.585712428241;14327.498537551135;13415.865841341461;13476.595702128952;13514.121582097525;13540.255285959367;13797.862021379658;13385.933070334586;13617.523386681418;13840.653983650489;13963.162210267417;14195.645108871948;11117.398296503701;11146.888531114586;11272.66182014541;11427.714307142389;11586.13104017219;7509.624518774149;9880.703578892644;10183.388996660224;10700.197485188797;11287.717807054561 09:53:18 INFO - PROCESS | 1656 | __end_tp_report 09:53:18 INFO - PROCESS | 1656 | __start_cc_report 09:53:18 INFO - PROCESS | 1656 | _x_x_mozilla_cycle_collect,371 09:53:18 INFO - PROCESS | 1656 | __end_cc_report 09:53:18 INFO - PROCESS | 1656 | __startTimestamp1474908798919__endTimestamp 09:53:18 INFO - PROCESS | 1656 | 09:53:18 INFO - PROCESS | 1656 | ------- Summary: start ------- 09:53:18 INFO - PROCESS | 1656 | Number of tests: 6 09:53:18 INFO - PROCESS | 1656 | 09:53:18 INFO - PROCESS | 1656 | [#0] dojo.html Cycles:165 Average:5764.98 Median:6069.64 stddev:691.07 (11.4%) stddev-sans-first:666.08 09:53:18 INFO - PROCESS | 1656 | Values: 3321.7 3391.6 3432.3 3433.1 3438.9 5341.3 5576.9 5714.3 5773.2 5782.7 4501.8 5676.3 5730.8 5791.6 5837.2 5201.9 5221.7 5281.8 5325.5 5362.9 5263.2 5282.0 5314.8 5357.3 5365.6 5162.6 5170.0 5215.3 5262.9 5287.0 5205.9 5211.5 5228.4 5315.0 5321.2 5229.6 5242.6 5248.4 5256.7 5341.2 5585.6 5674.1 5765.9 5785.8 5834.6 6215.7 6235.4 6305.9 6309.3 6309.4 6202.8 6292.3 6302.9 6305.1 6328.8 5711.6 5797.8 5825.9 5852.7 5864.1 6289.7 6366.3 6389.9 6407.9 6434.1 6196.3 6208.6 6215.4 6235.3 6247.8 6119.0 6197.5 6309.3 6311.0 6314.0 4790.9 6195.5 6261.8 6265.7 6272.4 6221.9 6223.9 6265.1 6278.5 6312.1 3953.5 4126.8 4364.4 4932.5 4943.5 4415.2 4424.4 4451.9 4469.1 4577.5 5834.1 5881.6 5883.3 5897.8 5922.2 6152.8 6307.1 6313.1 6316.2 6316.6 4866.5 5795.3 5846.3 5919.1 6000.1 5444.0 5482.4 5483.5 5488.7 5495.6 6321.9 6405.8 6411.6 6417.5 6420.7 6196.4 6228.2 6238.9 6248.6 6333.9 6420.0 6432.5 6448.5 6451.4 6467.4 6114.7 6162.6 6258.7 6291.7 6298.0 6237.8 6269.3 6290.5 6298.8 6311.0 4902.8 6066.4 6168.6 6195.4 6198.2 6159.3 6191.3 6199.1 6203.9 6209.2 5852.2 5900.1 5951.3 5996.3 6071.4 6176.4 6177.3 6195.6 6202.5 6211.3 6069.6 6073.8 6086.8 6113.1 6113.3 09:53:18 INFO - PROCESS | 1656 | 09:53:18 INFO - PROCESS | 1656 | [#1] ext.html Cycles:180 Average:71482.42 Median:38591.92 stddev:163698.96 (424.2%) stddev-sans-first:164071.35 09:53:18 INFO - PROCESS | 1656 | Values: 472.2 485.6 501.6 517.4 519.0 32412.8 40380.8 40407.8 42531.8 42585.1 40735.8 41120.8 41139.0 41201.4 41306.6 8055.9 8343.7 9890.3 9923.3 9935.3 9773.0 9783.4 9870.1 9873.2 9884.0 9885.0 9886.2 9910.0 9918.7 9945.1 8236.2 9748.7 9906.1 9913.2 9948.4 8361.4 9742.5 9771.1 9846.7 9851.3 39606.0 39947.2 39970.0 39984.4 40088.8 3115.8 3265.5 3375.7 3382.5 3440.9 30685.8 30879.5 31004.7 31757.8 32871.8 3209.6 3211.3 3233.7 3331.7 3349.5 506875.0 507142.0 515961.0 516693.0 518032.0 34208.0 58278.1 66457.7 66487.7 66591.7 34585.7 35551.6 35799.5 35840.3 35870.8 14688.8 14828.6 14869.6 14870.3 14874.9 12404.2 12546.4 12633.8 12638.4 12717.8 7816.4 7927.1 8024.6 8043.2 8071.2 2973.3 3394.7 3396.2 3414.4 3420.2 763.6 813.6 899.9 969.4 1140.6 25019.5 28554.7 29444.9 29994.3 30104.0 1054.3 1077.9 1082.2 1094.2 1105.9 13356.9 15224.8 15257.5 15269.5 15306.7 672960.0 679019.3 682390.0 682392.0 683354.0 49919.0 50946.0 51041.7 51520.5 51716.7 1343.7 1386.0 1405.1 1405.8 1410.3 28032.4 28757.7 28941.0 29461.4 29474.7 45919.8 46875.8 46910.8 46945.2 47019.8 621329.0 623916.0 625608.0 626795.0 627830.0 26829.3 26941.9 27044.9 27125.7 27176.5 44729.9 44962.8 45153.8 46053.8 46488.0 33209.3 34196.0 38088.4 38396.0 38549.2 30992.8 37320.4 37664.9 38570.8 38613.0 36855.8 37146.4 38268.2 38438.0 39555.8 29957.0 33907.3 34038.3 34182.5 34679.1 24314.5 24327.6 24649.9 25200.6 25484.6 09:53:18 INFO - PROCESS | 1656 | 09:53:18 INFO - PROCESS | 1656 | [#2] jquery.html Cycles:180 Average:34997.55 Median:13912.65 stddev:98936.93 (711.1%) stddev-sans-first:99180.29 09:53:18 INFO - PROCESS | 1656 | Values: 361.6 372.3 373.4 377.2 395.0 16342.7 19580.4 20227.7 20630.0 21184.7 20238.7 20442.3 20687.9 20769.8 21216.0 4641.7 5729.0 5956.3 6059.4 6137.4 5176.8 5997.3 6050.6 6094.8 6105.5 4709.7 4754.0 5283.5 6500.6 6718.2 6184.1 6644.2 6699.3 6740.2 6761.3 5077.7 5425.6 5869.7 5934.5 5960.8 10227.4 13214.7 18850.0 25554.4 25596.4 2115.2 2159.7 2243.2 2260.4 2270.9 9876.2 10076.1 10087.3 10429.2 10461.8 1864.6 1891.5 1913.6 1937.1 1974.2 127641.0 128424.4 129225.4 130221.0 131423.0 10872.9 11608.0 11630.5 11637.6 11795.3 14383.4 14478.2 14480.3 14540.6 14541.4 6932.3 8139.3 8364.0 8369.0 8378.7 7194.3 8128.7 8188.5 8247.8 8397.0 4484.0 4520.6 4525.3 4557.5 4560.3 1745.0 1883.9 1939.2 1945.8 1961.6 758.5 830.0 833.2 929.5 947.8 20388.4 20994.4 21841.1 21879.7 21935.7 871.8 897.8 916.4 928.3 974.8 10754.9 11267.8 11381.0 11487.0 11523.4 579189.9 579759.0 587554.0 597821.0 599459.0 136325.0 136623.0 138904.0 139438.3 142241.0 880.8 971.2 997.1 1017.5 1021.6 17758.8 18601.9 19446.7 19517.0 19517.5 41207.6 51784.7 53886.0 53999.7 55675.6 55691.7 76460.0 76867.4 77213.6 80403.6 7870.1 7983.5 8116.6 8149.3 8222.7 9043.3 11405.7 12743.1 12746.9 13221.3 11107.6 11109.4 11278.2 11386.8 11414.9 9527.2 11142.9 11206.4 11318.7 11694.2 11336.5 11638.9 12027.6 12069.8 12112.6 5399.7 7254.0 7393.5 8072.0 8310.4 9390.7 11334.1 11683.5 11741.6 11748.8 09:53:18 INFO - PROCESS | 1656 | 09:53:18 INFO - PROCESS | 1656 | [#3] mootools.html Cycles:180 Average:5740.58 Median:4566.58 stddev:3258.65 (71.4%) stddev-sans-first:3252.20 09:53:18 INFO - PROCESS | 1656 | Values: 1499.7 1538.7 1745.3 1806.1 1862.7 8126.3 8491.0 8609.9 9203.7 9250.0 8567.7 8964.2 8973.3 8993.3 9040.5 2335.3 2384.0 2387.8 2391.9 2399.8 2364.1 2383.6 2407.5 2409.0 2417.9 2367.4 2384.6 2390.6 2401.3 2403.4 2330.2 2346.9 2351.7 2354.2 2359.0 2343.7 2364.8 2367.0 2370.7 2377.0 8895.2 8933.6 9003.0 9005.4 9023.4 5276.1 5395.1 5414.6 5435.9 5443.2 3613.4 3632.5 3665.3 3675.3 3686.8 921.9 1068.5 1088.2 1093.7 1095.8 9974.9 10855.8 10914.5 11037.1 11887.2 3818.5 4170.3 4616.8 4807.6 4858.1 8997.6 9923.0 10066.2 10080.6 10184.6 4518.4 5363.0 5371.3 5396.8 5404.3 4331.1 4524.8 4735.9 4927.0 4962.5 3407.6 3875.6 3914.9 3980.3 4020.8 1062.3 1273.4 1276.1 1280.2 1286.2 833.6 908.9 913.6 929.3 942.5 4608.4 5857.2 6075.7 6134.9 6178.0 371.2 385.4 393.4 400.8 402.8 3986.7 3994.3 4025.9 4059.7 4107.2 10625.7 10906.4 11058.8 11125.3 11175.1 10909.6 10943.8 10950.4 11038.4 11085.6 8354.2 8424.3 8428.2 8439.5 8440.7 5180.6 5345.0 5827.7 6088.3 6092.1 10199.4 10286.3 10316.1 10369.4 10403.1 10087.8 10278.2 10331.0 10555.5 10556.4 6927.8 7154.6 7346.2 7459.3 7617.5 8445.7 8476.4 8535.8 8631.6 8639.1 7259.2 7260.8 7469.9 7580.7 7721.4 7372.7 7466.7 7481.4 7601.0 7609.1 7106.0 7208.6 7229.5 7238.0 7248.6 5014.7 5135.5 5148.4 5237.6 5254.8 5046.9 5048.5 5094.9 5095.6 5270.1 09:53:18 INFO - PROCESS | 1656 | 09:53:18 INFO - PROCESS | 1656 | [#4] prototype.html Cycles:180 Average:4693.17 Median:5327.29 stddev:1488.46 (27.9%) stddev-sans-first:1455.64 09:53:18 INFO - PROCESS | 1656 | Values: 299.1 303.7 310.4 311.7 314.3 4483.6 5430.4 5518.3 5543.7 5606.2 5213.0 5427.2 5445.8 5460.5 5483.8 3560.4 4177.5 4196.9 4205.6 4216.0 3429.9 3857.2 4191.8 4201.9 4233.8 3867.1 4105.6 4114.9 4143.3 4156.9 3224.0 4114.9 4133.6 4151.2 4176.0 3584.3 3591.3 3592.4 3602.7 3603.1 4564.6 4951.8 5047.5 5355.8 5393.4 4184.4 4384.5 4516.5 4571.5 4787.2 4874.6 5437.0 5688.3 5849.7 5860.8 3462.6 3802.4 3865.3 3899.5 3915.8 5003.9 6052.2 6140.9 6144.7 6184.9 3969.0 3988.5 4003.2 4007.0 4037.7 3744.3 3995.5 4030.8 4035.5 4053.5 4698.9 4727.9 4773.4 4779.3 4785.7 4776.9 5204.1 5913.3 5961.5 5972.7 1170.9 1321.5 1337.8 1364.4 1373.3 781.7 791.8 802.3 859.7 871.7 5395.8 5451.3 5453.1 5458.9 5553.9 5476.6 5947.1 5959.6 5974.2 5989.8 4561.5 5005.0 5120.8 5264.8 5515.8 2954.5 3118.5 3171.5 3180.1 3205.7 5298.8 6240.7 6333.0 6336.5 6347.9 5387.5 5868.5 5890.7 5988.6 6257.1 5202.9 5361.4 5556.8 6419.9 6472.2 5761.6 6044.7 6118.6 6145.4 6168.8 5633.4 5864.7 6041.9 6081.8 6099.7 5599.7 6360.0 6391.3 6398.9 6449.7 3377.9 3537.8 3687.5 3690.7 3968.5 5895.9 6098.7 6131.3 6144.4 6174.7 5659.2 5739.2 5813.5 5846.5 5868.5 4823.0 5463.8 5549.6 5623.4 5917.8 4546.9 4634.6 5619.4 5758.3 5912.7 5854.5 5860.5 5912.6 5961.7 5975.4 4734.8 4879.3 5120.8 5617.7 5830.9 09:53:18 INFO - PROCESS | 1656 | 09:53:18 INFO - PROCESS | 1656 | [#5] yui.html Cycles:180 Average:23878.11 Median:3785.02 stddev:37813.59 (999.0%) stddev-sans-first:37879.45 09:53:18 INFO - PROCESS | 1656 | Values: 651.9 658.9 712.0 724.9 781.5 14989.7 15908.0 15963.4 15989.0 16027.4 14167.2 14356.7 14367.9 14386.8 14390.7 666.0 685.2 785.5 826.8 830.8 829.2 840.1 840.3 842.3 842.9 899.4 902.4 904.4 904.5 904.6 890.1 893.1 894.3 899.6 900.4 561.8 666.1 666.3 670.8 673.9 14365.7 14628.9 14863.1 14874.5 14903.0 14426.2 14467.6 14545.9 14550.8 14599.9 9892.3 11684.9 11809.0 11812.8 11928.6 3712.0 3780.2 3789.8 3794.1 3810.7 112824.0 114203.0 114897.4 114952.3 118934.0 11057.4 11178.4 11227.0 11249.0 11532.7 23017.3 23036.8 23058.5 23072.0 23171.9 7192.6 7493.7 7989.1 8208.4 8312.3 4405.4 4414.4 4439.5 4484.5 4528.7 3429.6 3516.8 3547.6 3578.4 3579.7 657.6 658.4 661.8 663.6 667.7 560.0 585.2 604.1 610.2 634.2 8897.7 9046.7 9070.5 9143.5 9255.9 493.6 573.9 584.1 637.7 645.5 4355.7 4572.4 4681.9 4687.4 4711.4 122606.0 148116.3 150858.2 153067.0 154420.0 77386.9 114134.0 114771.4 122186.4 125126.1 98118.0 108444.0 108589.0 108941.5 109417.5 8960.0 9128.8 9489.3 9861.8 9941.0 56783.0 57832.4 58063.0 58840.0 59481.0 72555.3 76041.0 77779.0 89170.6 89254.6 8661.0 10485.5 12603.9 12632.7 13021.4 14468.3 14578.6 14678.4 14798.9 15062.7 10757.2 11814.0 13406.1 13809.6 14327.5 13415.9 13476.6 13514.1 13540.3 13797.9 13385.9 13617.5 13840.7 13963.2 14195.6 11117.4 11146.9 11272.7 11427.7 11586.1 7509.6 9880.7 10183.4 10700.2 11287.7 09:53:18 INFO - PROCESS | 1656 | -------- Summary: end -------- 09:53:18 INFO - PROCESS | 1656 | 09:53:19 INFO - TEST-INFO | 1656: exit 0 09:53:19 INFO - TEST-OK | dromaeo_css | took 1113647ms 09:53:19 INFO - TEST-START | kraken 09:53:19 INFO - operating with platform_type : mac_ 09:53:19 INFO - Initialising browser for kraken test... 09:53:19 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/tmp27HLn9/profile http://localhost:49276/getInfo.html) 09:53:22 INFO - PROCESS | 1667 | 2016-09-26 09:53:22.274 plugin-container[1668:9980] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a1f, name = 'com.apple.tsm.portname' 09:53:22 INFO - PROCESS | 1667 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:53:22 INFO - PROCESS | 1667 | 2016-09-26 09:53:22.277 plugin-container[1668:9980] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9003, name = 'com.apple.CFPasteboardClient' 09:53:22 INFO - PROCESS | 1667 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:53:22 INFO - PROCESS | 1667 | 2016-09-26 09:53:22.277 plugin-container[1668:9980] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:53:22 INFO - PROCESS | 1667 | __metrics Screen width/height:1600/1200 09:53:22 INFO - PROCESS | 1667 | colorDepth:24 09:53:22 INFO - PROCESS | 1667 | Browser inner width/height: 1024/689 09:53:22 INFO - PROCESS | 1667 | __metrics 09:53:22 ERROR - PROCESS | 1667 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 09:53:23 INFO - TEST-INFO | 1667: exit 0 09:53:23 INFO - Browser initialized. 09:53:23 INFO - Running cycle 1/1 for kraken test... 09:53:23 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/tmp27HLn9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:53:25 INFO - PROCESS | 1669 | 2016-09-26 09:53:25.618 plugin-container[1670:10090] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x891f, name = 'com.apple.tsm.portname' 09:53:25 INFO - PROCESS | 1669 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:53:25 INFO - PROCESS | 1669 | 2016-09-26 09:53:25.621 plugin-container[1670:10090] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c1b, name = 'com.apple.CFPasteboardClient' 09:53:25 INFO - PROCESS | 1669 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:53:25 INFO - PROCESS | 1669 | 2016-09-26 09:53:25.621 plugin-container[1670:10090] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:53:35 INFO - PROCESS | 1669 | RSS: Main: 239927296 09:53:35 INFO - PROCESS | 1669 | 09:53:37 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection) 09:53:38 INFO - PROCESS | 1669 | RSS: Main: 253419520 09:53:38 INFO - PROCESS | 1669 | 09:53:41 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-dft) 09:53:42 INFO - PROCESS | 1669 | RSS: Main: 261947392 09:53:42 INFO - PROCESS | 1669 | 09:53:45 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-fft) 09:53:45 INFO - PROCESS | 1669 | RSS: Main: 261668864 09:53:45 INFO - PROCESS | 1669 | 09:53:47 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator) 09:53:48 INFO - PROCESS | 1669 | RSS: Main: 263954432 09:53:48 INFO - PROCESS | 1669 | 09:53:50 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:53:51 INFO - PROCESS | 1669 | RSS: Main: 264404992 09:53:51 INFO - PROCESS | 1669 | 09:53:53 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom) 09:53:54 INFO - PROCESS | 1669 | RSS: Main: 265408512 09:53:54 INFO - PROCESS | 1669 | 09:53:57 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate) 09:53:58 INFO - PROCESS | 1669 | RSS: Main: 265289728 09:53:58 INFO - PROCESS | 1669 | 09:54:01 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial) 09:54:02 INFO - PROCESS | 1669 | RSS: Main: 265863168 09:54:02 INFO - PROCESS | 1669 | 09:54:03 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:54:04 INFO - PROCESS | 1669 | RSS: Main: 265420800 09:54:04 INFO - PROCESS | 1669 | 09:54:06 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:54:06 INFO - PROCESS | 1669 | RSS: Main: 265506816 09:54:06 INFO - PROCESS | 1669 | 09:54:09 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:54:09 INFO - PROCESS | 1669 | RSS: Main: 265531392 09:54:09 INFO - PROCESS | 1669 | 09:54:12 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:54:13 INFO - PROCESS | 1669 | RSS: Main: 265531392 09:54:13 INFO - PROCESS | 1669 | 09:54:16 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:54:17 INFO - PROCESS | 1669 | RSS: Main: 265842688 09:54:17 INFO - PROCESS | 1669 | 09:54:19 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49276/tests/kraken/driver.html?testName=ai-astar) 09:54:19 INFO - PROCESS | 1669 | RSS: Main: 267415552 09:54:19 INFO - PROCESS | 1669 | 09:54:19 INFO - PROCESS | 1669 | __start_tp_report 09:54:19 INFO - PROCESS | 1669 | _x_x_mozilla_page_load 09:54:19 INFO - PROCESS | 1669 | _x_x_mozilla_page_load_details 09:54:19 INFO - PROCESS | 1669 | |i|pagename|runs| 09:54:19 INFO - PROCESS | 1669 | |0;ai-astar;116;122;118;116;117;116;116;117;125;116 09:54:19 INFO - PROCESS | 1669 | |1;audio-beat-detection;140;119;139;175;112;112;112;115;142;112 09:54:19 INFO - PROCESS | 1669 | |2;audio-dft;201;200;197;205;213;216;196;200;199;201 09:54:19 INFO - PROCESS | 1669 | |3;audio-fft;81;58;57;80;65;76;81;84;99;61 09:54:19 INFO - PROCESS | 1669 | |4;audio-oscillator;88;70;87;72;70;68;88;69;71;87 09:54:19 INFO - PROCESS | 1669 | |5;imaging-gaussian-blur;89;87;90;89;86;116;96;79;77;116 09:54:19 INFO - PROCESS | 1669 | |6;imaging-darkroom;130;175;105;114;173;117;173;166;100;142 09:54:19 INFO - PROCESS | 1669 | |7;imaging-desaturate;92;95;96;139;147;90;91;90;92;92 09:54:19 INFO - PROCESS | 1669 | |8;json-parse-financial;57;57;56;57;58;58;58;58;59;57 09:54:19 INFO - PROCESS | 1669 | |9;json-stringify-tinderbox;71;74;74;84;80;75;72;89;89;110 09:54:19 INFO - PROCESS | 1669 | |10;stanford-crypto-aes;89;88;87;79;102;106;112;100;90;88 09:54:19 INFO - PROCESS | 1669 | |11;stanford-crypto-ccm;151;155;164;131;156;155;148;158;202;149 09:54:19 INFO - PROCESS | 1669 | |12;stanford-crypto-pbkdf2;224;239;182;171;171;178;174;172;197;240 09:54:19 INFO - PROCESS | 1669 | |13;stanford-crypto-sha256-iterative;72;69;70;71;67;69;80;76;73;68 09:54:19 INFO - PROCESS | 1669 | __end_tp_report 09:54:19 INFO - PROCESS | 1669 | __start_cc_report 09:54:19 INFO - PROCESS | 1669 | _x_x_mozilla_cycle_collect,941 09:54:19 INFO - PROCESS | 1669 | __end_cc_report 09:54:19 INFO - PROCESS | 1669 | __startTimestamp1474908859332__endTimestamp 09:54:19 INFO - PROCESS | 1669 | 09:54:19 INFO - PROCESS | 1669 | ------- Summary: start ------- 09:54:19 INFO - PROCESS | 1669 | Number of tests: 14 09:54:19 INFO - PROCESS | 1669 | 09:54:19 INFO - PROCESS | 1669 | [#0] ai-astar Cycles:10 Average:117.90 Median:117.00 stddev:3.11 (2.7%) stddev-sans-first:3.22 09:54:19 INFO - PROCESS | 1669 | Values: 116.0 122.0 118.0 116.0 117.0 116.0 116.0 117.0 125.0 116.0 09:54:19 INFO - PROCESS | 1669 | 09:54:19 INFO - PROCESS | 1669 | [#1] audio-beat-detection Cycles:10 Average:127.80 Median:129.00 stddev:20.93 (16.2%) stddev-sans-first:21.73 09:54:19 INFO - PROCESS | 1669 | Values: 140.0 119.0 139.0 175.0 112.0 112.0 112.0 115.0 142.0 112.0 09:54:19 INFO - PROCESS | 1669 | 09:54:19 INFO - PROCESS | 1669 | [#2] audio-dft Cycles:10 Average:202.80 Median:201.00 stddev:6.66 (3.3%) stddev-sans-first:7.04 09:54:19 INFO - PROCESS | 1669 | Values: 201.0 200.0 197.0 205.0 213.0 216.0 196.0 200.0 199.0 201.0 09:54:19 INFO - PROCESS | 1669 | 09:54:19 INFO - PROCESS | 1669 | [#3] audio-fft Cycles:10 Average:74.20 Median:80.50 stddev:13.57 (16.9%) stddev-sans-first:14.17 09:54:19 INFO - PROCESS | 1669 | Values: 81.0 58.0 57.0 80.0 65.0 76.0 81.0 84.0 99.0 61.0 09:54:19 INFO - PROCESS | 1669 | 09:54:19 INFO - PROCESS | 1669 | [#4] audio-oscillator Cycles:10 Average:77.00 Median:79.50 stddev:9.10 (11.5%) stddev-sans-first:8.74 09:54:19 INFO - PROCESS | 1669 | Values: 88.0 70.0 87.0 72.0 70.0 68.0 88.0 69.0 71.0 87.0 09:54:19 INFO - PROCESS | 1669 | 09:54:19 INFO - PROCESS | 1669 | [#5] imaging-gaussian-blur Cycles:10 Average:92.50 Median:88.00 stddev:13.51 (15.4%) stddev-sans-first:14.27 09:54:19 INFO - PROCESS | 1669 | Values: 89.0 87.0 90.0 89.0 86.0 116.0 96.0 79.0 77.0 116.0 09:54:19 INFO - PROCESS | 1669 | 09:54:19 INFO - PROCESS | 1669 | [#6] imaging-darkroom Cycles:10 Average:139.50 Median:154.00 stddev:30.20 (19.6%) stddev-sans-first:31.84 09:54:19 INFO - PROCESS | 1669 | Values: 130.0 175.0 105.0 114.0 173.0 117.0 173.0 166.0 100.0 142.0 09:54:19 INFO - PROCESS | 1669 | 09:54:19 INFO - PROCESS | 1669 | [#7] imaging-desaturate Cycles:10 Average:102.40 Median:92.00 stddev:21.57 (23.4%) stddev-sans-first:22.55 09:54:19 INFO - PROCESS | 1669 | Values: 92.0 95.0 96.0 139.0 147.0 90.0 91.0 90.0 92.0 92.0 09:54:19 INFO - PROCESS | 1669 | 09:54:19 INFO - PROCESS | 1669 | [#8] json-parse-financial Cycles:10 Average:57.50 Median:58.00 stddev:0.85 (1.5%) stddev-sans-first:0.88 09:54:19 INFO - PROCESS | 1669 | Values: 57.0 57.0 56.0 57.0 58.0 58.0 58.0 58.0 59.0 57.0 09:54:19 INFO - PROCESS | 1669 | 09:54:19 INFO - PROCESS | 1669 | [#9] json-stringify-tinderbox Cycles:10 Average:81.80 Median:77.50 stddev:11.96 (15.4%) stddev-sans-first:12.03 09:54:19 INFO - PROCESS | 1669 | Values: 71.0 74.0 74.0 84.0 80.0 75.0 72.0 89.0 89.0 110.0 09:54:19 INFO - PROCESS | 1669 | 09:54:19 INFO - PROCESS | 1669 | [#10] stanford-crypto-aes Cycles:10 Average:94.10 Median:87.50 stddev:10.30 (11.8%) stddev-sans-first:10.76 09:54:19 INFO - PROCESS | 1669 | Values: 89.0 88.0 87.0 79.0 102.0 106.0 112.0 100.0 90.0 88.0 09:54:19 INFO - PROCESS | 1669 | 09:54:19 INFO - PROCESS | 1669 | [#11] stanford-crypto-ccm Cycles:10 Average:156.90 Median:155.50 stddev:18.08 (11.6%) stddev-sans-first:19.05 09:54:19 INFO - PROCESS | 1669 | Values: 151.0 155.0 164.0 131.0 156.0 155.0 148.0 158.0 202.0 149.0 09:54:19 INFO - PROCESS | 1669 | 09:54:19 INFO - PROCESS | 1669 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:194.80 Median:189.50 stddev:28.65 (15.1%) stddev-sans-first:28.37 09:54:19 INFO - PROCESS | 1669 | Values: 224.0 239.0 182.0 171.0 171.0 178.0 174.0 172.0 197.0 240.0 09:54:19 INFO - PROCESS | 1669 | 09:54:19 INFO - PROCESS | 1669 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.50 Median:71.50 stddev:3.98 (5.6%) stddev-sans-first:4.22 09:54:19 INFO - PROCESS | 1669 | Values: 72.0 69.0 70.0 71.0 67.0 69.0 80.0 76.0 73.0 68.0 09:54:19 INFO - PROCESS | 1669 | -------- Summary: end -------- 09:54:19 INFO - PROCESS | 1669 | 09:54:20 INFO - TEST-INFO | 1669: exit 0 09:54:20 INFO - TEST-OK | kraken | took 60644ms 09:54:20 INFO - SUITE-END | took 1174s 09:54:20 INFO - Completed test suite (00:19:34) 09:54:20 INFO - javascript benchmark 09:54:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7248.4773109195685, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3321.6512266212044, 3391.643877392872, 3432.3478539077587, 3433.124553238924, 3438.948415773763, 5341.252224688542, 5576.856744367395, 5714.285714285715, 5773.162891380747, 5782.710864456782, 4501.819927202908, 5676.262085928824, 5730.79942202023, 5791.623544469607, 5837.211976383187, 5201.869953251161, 5221.738913054351, 5281.788728450857, 5325.4940780625775, 5362.865928351784, 5263.1578947368425, 5281.996420680078, 5314.787408503656, 5357.330333708267, 5365.597580181482, 5162.638615296931, 5170.043541944752, 5215.269862219292, 5262.868428289324, 5286.9690410370185, 5205.869853253661, 5211.478852114796, 5228.398734145584, 5315.0, 5321.228421878806, 5229.633925625208, 5242.606804489678, 5248.370195576517, 5256.684598924076, 5341.2255222992835, 5585.553155747531, 5674.120511320752, 5765.855853603652, 5785.797497087582, 5834.649921004753, 6215.720292586844, 6235.407636274546, 6305.936940630627, 6309.305976342599, 6309.400606942379, 6202.782902598433, 6292.33930437302, 6302.9369706302805, 6305.148804911324, 6328.8101356958905, 5711.600187986801, 5797.768089276382, 5825.88348233033, 5852.707364631751, 5864.1203819427, 6289.7484100636375, 6366.26787919386, 6389.904151437732, 6407.935920640827, 6434.131392261985, 6196.318404975449, 6208.627482350983, 6215.409536094064, 6235.282942461584, 6247.843803904939, 6118.95422233728, 6197.4732147767945, 6309.337519560472, 6310.968445157837, 6314.0, 4790.880227994258, 6195.504359651217, 6261.843453913689, 6265.749370025239, 6272.372762723691, 6221.906671399933, 6223.906641400383, 6265.091561723616, 6278.529110316745, 6312.116303717483, 3953.5058117735284, 4126.7523948563185, 4364.367166760802, 4932.53140951609, 4943.505649435027, 4415.161119387306, 4424.446944131983, 4451.86644400662, 4469.08383781324, 4577.496475387705, 5834.095715164156, 5881.647101173943, 5883.264591926009, 5897.76408943646, 5922.230110085661, 6152.78465253714, 6307.05394190875, 6313.116163737081, 6316.178896743394, 6316.557840951089, 4866.46468888422, 5795.304563452329, 5846.298444186725, 5919.082542205879, 6000.129981152796, 5443.972780136074, 5482.396936337, 5483.4516548344845, 5488.725563721798, 5495.560355171577, 6321.905171422524, 6405.775797847053, 6411.6153030818305, 6417.454516366161, 6420.6789660517725, 6196.411340922605, 6228.159198508143, 6238.937610624017, 6248.593841400295, 6333.936660633335, 6420.0, 6432.517561183024, 6448.484121270193, 6451.3548645135115, 6467.417932386108, 6114.6942652868065, 6162.613411982447, 6258.655773932477, 6291.653959032297, 6298.02380631003, 6237.812865614039, 6269.279032911274, 6290.528210384148, 6298.84252893663, 6310.968445157745, 4902.828401005948, 6066.423689749467, 6168.599041062316, 6195.4424101831055, 6198.2252218472695, 6159.322474527708, 6191.288001879841, 6199.132121503083, 6203.906941395792, 6209.161763161916, 5852.239208902985, 5900.11498275245, 5951.345352011189, 5996.280446346466, 6071.362506936708, 6176.382361763787, 6177.2587289525545, 6195.566310358232, 6202.534809889186, 6211.2857021441305, 6069.635821850703, 6073.848153796191, 6086.817395478142, 6113.050656958906, 6113.301452621278], "value": 5720.278846368547, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [472.22319284776523, 485.64790526868023, 501.6488458079345, 517.4049842680918, 518.9532942035221, 32412.837935810316, 40380.78857634272, 40407.787766366986, 42531.787341063326, 42585.14829703412, 40735.79632101835, 41120.79439602805, 41139.0, 41201.381979270336, 41306.586934130646, 8055.9194408055755, 8343.707970221043, 9890.258230632695, 9923.255755818307, 9935.254855885802, 9772.951135244313, 9783.412995220275, 9870.062344077302, 9873.210143188528, 9883.950580247089, 9885.01149885013, 9886.159676427513, 9909.95045024774, 9918.702438926808, 9945.055219754111, 8236.176382361746, 9748.658796942143, 9906.108450239513, 9913.206943444507, 9948.403095814201, 8361.372897032747, 9742.464164470952, 9771.12059914611, 9846.704598862045, 9851.310408271424, 39606.0, 39947.20105597901, 39970.0, 39984.40101393429, 40088.799556002035, 3115.766317526172, 3265.4775235962134, 3375.6793104655017, 3382.543356646846, 3440.896773096811, 30685.846570767226, 30879.536806947915, 31004.68995310063, 31757.8412107938, 32871.83564082188, 3209.5667084943702, 3211.2614098757185, 3233.7413006959623, 3331.68349006844, 3349.4592487455798, 506875.0, 507142.0, 515961.0, 516693.0, 518032.0, 34208.0, 58278.125828112614, 66457.66771166114, 66487.66756166189, 66591.66704166448, 34585.65414345825, 35551.64448355535, 35799.4630080549, 35840.28319433649, 35870.8206458966, 14688.779668304984, 14828.555143345717, 14869.628259293388, 14870.330835112445, 14874.851251487347, 12404.19372740787, 12546.435410406553, 12633.810492842615, 12638.368081595883, 12717.809232861515, 7816.41376896735, 7927.088384835818, 8024.598770061473, 8043.235892590312, 8071.152528984489, 2973.3012742005612, 3394.6775056369606, 3396.2018925552475, 3414.4195486767308, 3420.247545539977, 763.6220071064747, 813.556611646654, 899.8560230363111, 969.4038166527675, 1140.589387820384, 25019.499610007697, 28554.714452855205, 29444.852775735984, 29994.25014374658, 30104.0, 1054.288355360129, 1077.8814330423647, 1082.242430298794, 1094.179365475893, 1105.90599799018, 13356.866431335757, 15224.771628425582, 15257.476782426042, 15269.541913742605, 15306.693866122838, 672960.0, 679019.258844471, 682390.0, 682392.0, 683354.0, 49919.0, 50946.0, 51041.74479127581, 51520.48479515157, 51716.74141629343, 1343.7043850352907, 1385.9792103118461, 1405.1358414575168, 1405.7961595568586, 1410.2666613360996, 28032.439351212455, 28757.712422875502, 28940.98706545261, 29461.410771784875, 29474.705252947195, 45919.77040114778, 46875.76562117304, 46910.82722931817, 46945.18328900277, 47019.76490117527, 621329.0, 623916.0, 625608.0, 626795.0, 627830.0, 26829.329266768487, 26941.922323106857, 27044.91820327165, 27125.72874271232, 27176.456470870868, 44729.88175295643, 44962.77518612386, 45153.774231128635, 46053.76973115113, 46488.0, 33209.33581328408, 34195.97412077642, 38088.42867357047, 38396.0, 38549.229015418976, 30992.845035774677, 37320.44019339658, 37664.87005389843, 38570.80714596409, 38613.03467413225, 36855.81572092122, 37146.44280335743, 38268.234635307694, 38438.0, 39555.80222098871, 29957.0, 33907.321853563284, 34038.319233615686, 34182.53079507267, 34679.13302167365, 24314.51370972606, 24327.635085474085, 24649.87675061613, 25200.621990670523, 25484.617730733684], "value": 18514.043655064277, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.55889814426405, 372.2982178593351, 373.4118762948357, 377.2135098320003, 394.97827619480915, 16342.673146537061, 19580.398666128327, 20227.696584551242, 20630.0, 21184.682229766546, 20238.66634684574, 20442.2845200418, 20687.896560517176, 20769.792302076974, 21216.0, 4641.698289611181, 5728.9974254505505, 5956.34480207178, 6059.3637668044885, 6137.355577664325, 5176.818811341604, 5997.280326360821, 6050.606710563821, 6094.756209751605, 6105.511559075263, 4709.7174169549935, 4753.976230118845, 5283.524482796547, 6500.642464664442, 6718.160229971254, 6184.103305020747, 6644.169478815148, 6699.296573859748, 6740.191177058759, 6761.290064543201, 5077.695338279715, 5425.643589102724, 5869.735861886183, 5934.465898069195, 5960.761569537257, 10227.437490937995, 13214.735705285937, 18850.0, 25554.361140971625, 25596.36009099769, 2115.217369573252, 2159.7192364992607, 2243.1924507177405, 2260.3666728261555, 2270.94401103486, 9876.160526355268, 10076.143527800146, 10087.34432261908, 10429.165666746641, 10461.84307235392, 1864.5804693943753, 1891.4703882912806, 1913.6172765446827, 1937.1282922684848, 1974.1511150205406, 127641.0, 128424.35787821094, 129225.35387323004, 130221.0, 131423.0, 10872.891271087188, 11608.0, 11630.476628551736, 11637.592684256011, 11795.29228246308, 14383.424663013571, 14478.203698796457, 14480.348384322731, 14540.563783086523, 14541.418343266363, 6932.296404402186, 8139.267465928095, 8364.0, 8368.958155209306, 8378.748637540884, 7194.316539928698, 8128.715494957648, 8188.50868947865, 8247.752567422987, 8396.992360916607, 4484.0, 4520.615747661485, 4525.321201819687, 4557.453105627346, 4560.338750881104, 1744.9791871755165, 1883.8681292309407, 1939.224310275901, 1945.7956914524054, 1961.5880665060213, 758.4993904023429, 829.9792505187419, 833.1626715151234, 929.5305870535336, 947.772534591693, 20388.388348349574, 20994.37016889496, 21841.126354945623, 21879.67180492294, 21935.67096493554, 871.8125602995386, 897.8159477307137, 916.4409710076848, 928.3455164109287, 974.8245315843217, 10754.946225268981, 11267.774644507228, 11381.032612228053, 11487.0, 11523.423828808525, 579189.8729114316, 579759.0, 587554.0, 597821.0, 599459.0054099403, 136325.0, 136623.0, 138904.0, 139438.30280848735, 142241.0, 880.8416931734748, 971.1890571372842, 997.1225321716843, 1017.531935309751, 1021.5709402051008, 17758.845675031083, 18601.9069904655, 19446.708299375237, 19517.0, 19517.51206219856, 41207.58792412037, 51784.74107629438, 53886.0, 53999.730001351316, 55675.60810979758, 55691.721541392035, 76460.0, 76867.44467522367, 77213.61393192998, 80403.59798200971, 7870.09493908185, 7983.5209887406945, 8116.553589552631, 8149.307308878811, 8222.671093156447, 9043.342678520436, 11405.688345840003, 12743.10798244114, 12746.872531274568, 13221.272829994443, 11107.611233606785, 11109.388983605979, 11278.210525263154, 11386.772264554827, 11414.942925285653, 9527.237820974167, 11142.888571114509, 11206.43967801623, 11318.717032074264, 11694.181407301407, 11336.489857956247, 11638.941805290919, 12027.579034734092, 12069.818952715541, 12112.576059837864, 5399.676019438846, 7254.0, 7393.482456228013, 8071.959640201761, 8310.418270720991, 9390.718278451657, 11334.149938754792, 11683.474243658886, 11741.647750567497, 11748.765024699629], "value": 9444.743205121486, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1499.7300485912535, 1538.6845696632188, 1745.3367720266297, 1806.0788997611214, 1862.6833438315484, 8126.268635822775, 8491.023532293773, 8609.870851937218, 9203.677871274507, 9249.982501924791, 8567.65729370826, 8964.193222609963, 8973.327000474957, 8993.325500587465, 9040.502772347518, 2335.346103091133, 2384.046381447426, 2387.758365649861, 2391.880405979694, 2399.7720216579396, 2364.0543782487057, 2383.618621020637, 2407.5425669122897, 2409.012304954969, 2417.903283868643, 2367.3844800351862, 2384.6303822907475, 2390.5935990881594, 2401.3396316013063, 2403.351095204294, 2330.242671131889, 2346.894389752457, 2351.670766092748, 2354.176038386568, 2358.9646155307682, 2343.6836027136287, 2364.7871691547844, 2366.9526609467885, 2370.727366352857, 2377.037299893546, 8895.199432051082, 8933.59798809055, 9002.954985225031, 9005.369624126313, 9023.4134781239, 5276.12943864262, 5395.082835917864, 5414.648047876875, 5435.891282174334, 5443.1563107717975, 3613.385724426854, 3632.473291372736, 3665.303592317451, 3675.3016926783826, 3686.7787932724123, 921.8571121476182, 1068.476446541197, 1088.1947358954317, 1093.6937657455846, 1095.802755504017, 9974.85037724442, 10855.805861355244, 10914.508847101899, 11037.061849742782, 11887.227330223508, 3818.491695780151, 4170.311898536768, 4616.838410655611, 4807.591354734816, 4858.149823780895, 8997.595108220146, 9923.0, 10066.245031622657, 10080.59677612902, 10184.6435374763, 4518.412606361152, 5363.0, 5371.274877891513, 5396.784128634889, 5404.270423492778, 4331.068820203608, 4524.796384162721, 4735.928961065587, 4926.950730492721, 4962.528559786814, 3407.5570175877474, 3875.6318149775725, 3914.9021274467796, 3980.3233450313514, 4020.7788571628257, 1062.2511129653576, 1273.4333221716247, 1276.1003492537739, 1280.2382582363664, 1286.1897004886862, 833.6165363932538, 908.8500397434349, 913.57975331347, 929.3494553812224, 942.4593322342918, 4608.354830323758, 5857.179994800731, 6075.665838378932, 6134.938650613437, 6177.980633195562, 371.17598930374527, 385.35260761920244, 393.42952718558206, 400.80961543266716, 402.842891272404, 3986.720929534905, 3994.2610617035944, 4025.879223623296, 4059.654929330981, 4107.178564287155, 10625.681229563126, 10906.400147991937, 11058.778824423627, 11125.332480051224, 11175.105991520659, 10909.618163364245, 10943.781124377469, 10950.39772812503, 11038.392888391216, 11085.556577736801, 8354.248117669438, 8424.326053915673, 8428.241458268785, 8439.535825529532, 8440.704575339834, 5180.585553155814, 5344.9732751336, 5827.708614569339, 6088.299845517822, 6092.086187071975, 10199.439030853375, 10286.331388460025, 10316.123129534073, 10369.377837329785, 10403.115735162293, 10087.798244034931, 10278.229132814919, 10331.0, 10555.52500137511, 10556.419396933243, 6927.792166235021, 7154.569086182888, 7346.155192152757, 7459.328660420588, 7617.5048621839405, 8445.704400345958, 8476.36427267945, 8535.847660565743, 8631.56842157902, 8639.09289524616, 7259.2377800332315, 7260.782176534501, 7469.88795168062, 7580.696772129274, 7721.420893432903, 7372.7050917964825, 7466.664000119899, 7481.401487881065, 7601.0, 7609.124950630749, 7106.0, 7208.56748595086, 7229.530080544748, 7238.0, 7248.60132692707, 5014.749262536786, 5135.4850319156685, 5148.43367229612, 5237.633365664519, 5254.842354729364, 5046.949530504648, 5048.495150484922, 5094.949050509447, 5095.592352611856, 5270.077736396192], "value": 4508.611984206991, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.1086562045104, 303.6629341431011, 310.3869857032361, 311.7350252285559, 314.3116574701404, 4483.618892394143, 5430.3755068167175, 5518.255035570197, 5543.7249432630515, 5606.187102870086, 5213.0, 5427.2401863739005, 5445.809396671108, 5460.453954604538, 5483.7532311046, 3560.430331147017, 4177.4569305990335, 4196.916061678765, 4205.621494065534, 4215.957840421603, 3429.9142521436916, 3857.2092720992127, 4191.81136848841, 4201.852935147255, 4233.8094785734565, 3867.091233560111, 4105.609967053125, 4114.876553703393, 4143.316352801784, 4156.916861662765, 3223.9838800805965, 4114.938275925863, 4133.565975572582, 4151.169766046803, 4175.976885663002, 3584.318979393907, 3591.3356029134693, 3592.389293820057, 3602.6577475140084, 3603.117236277129, 4564.566366195239, 4951.752412379366, 5047.520485553867, 5355.7857685692525, 5393.379761327458, 4184.3932629768815, 4384.473863136413, 4516.503184649686, 4571.519990400993, 4787.186178349689, 4874.634402419797, 5437.0, 5688.293511946399, 5849.707514624294, 5860.765569377219, 3462.6364231755806, 3802.448644946495, 3865.2804014021444, 3899.454076429302, 3915.7846318452475, 5003.924941125886, 6052.21321228242, 6140.9385906140815, 6144.662043587601, 6184.87630247397, 3969.047428617169, 3988.521377434726, 4003.199360127986, 4006.959930400717, 4037.6971727119994, 3744.307303148926, 3995.5405128410025, 4030.7984600769846, 4035.515738111387, 4053.452783874139, 4698.85903422891, 4727.881802954954, 4773.355596994361, 4779.330893674888, 4785.688930219525, 4776.928346074812, 5204.100503316262, 5913.285147307319, 5961.463468287875, 5972.701364931736, 1170.9121815863843, 1321.4714114354335, 1337.77257866163, 1364.3928451838835, 1373.2996171952377, 781.7101782059533, 791.8257983243677, 802.3220378779922, 859.7420773767844, 871.6600525794818, 5395.757190926418, 5451.291332126877, 5453.072977593819, 5458.945410545924, 5553.888922221614, 5476.58925580583, 5947.1343626642165, 5959.553033522503, 5974.193483879708, 5989.837063241006, 4561.498235194126, 5005.024020316004, 5120.846374608694, 5264.842054738364, 5515.779368825282, 2954.5125054366217, 3118.5342888842206, 3171.5084161954933, 3180.0936733030976, 3205.743540516753, 5298.788048478094, 6240.65676387794, 6333.041848844472, 6336.528753786027, 6347.873042539123, 5387.545362752114, 5868.532866783305, 5890.734916928663, 5988.640681559121, 6257.092721555349, 5202.869928251824, 5361.356637203405, 5556.833295001156, 6419.935800641933, 6472.190976127984, 5761.596688231783, 6044.697765111815, 6118.571699980958, 6145.385461453819, 6168.845778855564, 5633.352164501135, 5864.736086876015, 6041.879162416815, 6081.787137450168, 6099.695015249131, 5599.684074242631, 6359.96820015897, 6391.296957334783, 6398.904016439664, 6449.7420103195345, 3377.9190658988887, 3537.823108844599, 3687.5021872048005, 3690.741648084608, 3968.543617483911, 5895.882082358243, 6098.664573448503, 6131.264248290234, 6144.354842741448, 6174.660393678211, 5659.179418984142, 5739.2252045973255, 5813.453793186069, 5846.503047241032, 5868.5305175585, 4822.99845564087, 5463.808766693306, 5549.611527193219, 5623.437656234344, 5917.822465326047, 4546.930821695409, 4634.629229661551, 5619.353774315842, 5758.3090029196765, 5912.674802885883, 5854.502367298827, 5860.531157507304, 5912.556558258234, 5961.701914904324, 5975.37258587842, 4734.810607575659, 4879.341288926092, 5120.769565369642, 5617.74170980822, 5830.892130495193], "value": 4208.660464525637, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [651.8500744828689, 658.9439897608703, 711.9964400177998, 724.87314719924, 781.4998401023346, 14989.700205995874, 15908.0, 15963.441279555218, 15989.040657560554, 16027.439039633615, 14167.220802855838, 14356.712865742678, 14367.856321436782, 14386.784198237008, 14390.712185756278, 665.9800205993804, 685.2325395556983, 785.4658831994242, 826.7974346285168, 830.8421399933993, 829.1956801902145, 840.0717207485732, 840.3319361107904, 842.296682270305, 842.8946381702287, 899.3749344205779, 902.4314681750488, 904.3985749476623, 904.4618452021037, 904.6471875968377, 890.0921060518267, 893.0845882970008, 894.2667013049302, 899.5906862377635, 900.3517467423445, 561.8370672504968, 666.1240468783534, 666.340323080152, 670.8289386206535, 673.9090222819906, 14365.712685746332, 14628.853711462856, 14863.108213507225, 14874.479393221294, 14903.0, 14426.206558639271, 14467.565973020826, 14545.92727036358, 14550.781738273934, 14599.927000365036, 9892.30753847231, 11684.941575292154, 11809.038980666297, 11812.822807657893, 11928.633811603244, 3711.997760604622, 3780.243951209769, 3789.7915614641183, 3794.070452739069, 3810.6951443884423, 112824.0, 114203.0, 114897.42551287274, 114952.27571586432, 118933.99999999914, 11057.391843448526, 11178.44107794607, 11227.045701115496, 11249.043831274434, 11532.731399546043, 23017.309480715605, 23036.769632303796, 23058.538829223657, 23072.0, 23171.88414057919, 7192.604406757574, 7493.737719179802, 7989.121196668362, 8208.425410221347, 8312.33501319893, 4405.383246345515, 4414.381986521889, 4439.467263928284, 4484.461864576272, 4528.682992190581, 3429.6227414984332, 3516.771409858351, 3547.6452354764833, 3578.4274516077303, 3579.7494175407473, 657.6288438605561, 658.4403257231411, 661.8246164766341, 663.5885750834514, 667.6761770541284, 559.9608027438122, 585.1807469542589, 604.145134634496, 610.176262046234, 634.1977398590786, 8897.688580899638, 9046.683366082156, 9070.455772653662, 9143.54282285883, 9255.90744092564, 493.6248451177131, 573.8880918220907, 584.1442287049493, 637.7066549387241, 645.5384400153819, 4355.73865568067, 4572.4055872736335, 4681.9297710534365, 4687.414073240845, 4711.387519622427, 122606.0, 148116.25941870222, 150858.24570877076, 153067.0, 154420.0, 77386.93969784005, 114134.0, 114771.42614287042, 122186.3890680541, 125126.12310815345, 98118.0, 108444.0, 108589.0, 108941.45529272461, 109417.45291273652, 8960.0, 9128.817423651622, 9489.335746497678, 9861.840397707792, 9940.950295248478, 56783.0, 57832.42167578439, 58063.0, 58840.0, 59481.0, 72555.27444725485, 76041.0, 77779.0, 89170.55414722885, 89254.55372723094, 8661.0, 10485.52815123306, 12603.87396126027, 12632.747345052863, 13021.414036368576, 14468.27658617086, 14578.562643120724, 14678.412863485768, 14798.926005369904, 15062.698746024798, 10757.246992710436, 11814.0, 13406.128601640861, 13809.585712428241, 14327.498537551135, 13415.865841341461, 13476.595702128952, 13514.121582097525, 13540.255285959367, 13797.862021379658, 13385.933070334586, 13617.523386681418, 13840.653983650489, 13963.162210267417, 14195.645108871948, 11117.398296503701, 11146.888531114586, 11272.66182014541, 11427.714307142389, 11586.13104017219, 7509.624518774149, 9880.703578892644, 10183.388996660224, 10700.197485188797, 11287.717807054561], "value": 7640.875097800199, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1590.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 122.0, 118.0, 116.0, 117.0, 116.0, 116.0, 117.0, 125.0, 116.0], "value": 117.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 119.0, 139.0, 175.0, 112.0, 112.0, 112.0, 115.0, 142.0, 112.0], "value": 127.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [201.0, 200.0, 197.0, 205.0, 213.0, 216.0, 196.0, 200.0, 199.0, 201.0], "value": 202.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 58.0, 57.0, 80.0, 65.0, 76.0, 81.0, 84.0, 99.0, 61.0], "value": 74.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 70.0, 87.0, 72.0, 70.0, 68.0, 88.0, 69.0, 71.0, 87.0], "value": 77.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 90.0, 89.0, 86.0, 116.0, 96.0, 79.0, 77.0, 116.0], "value": 92.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 175.0, 105.0, 114.0, 173.0, 117.0, 173.0, 166.0, 100.0, 142.0], "value": 139.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 95.0, 96.0, 139.0, 147.0, 90.0, 91.0, 90.0, 92.0, 92.0], "value": 102.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 56.0, 57.0, 58.0, 58.0, 58.0, 58.0, 59.0, 57.0], "value": 57.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 74.0, 74.0, 84.0, 80.0, 75.0, 72.0, 89.0, 89.0, 110.0], "value": 81.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 87.0, 79.0, 102.0, 106.0, 112.0, 100.0, 90.0, 88.0], "value": 94.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 155.0, 164.0, 131.0, 156.0, 155.0, 148.0, 158.0, 202.0, 149.0], "value": 156.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [224.0, 239.0, 182.0, 171.0, 171.0, 178.0, 174.0, 172.0, 197.0, 240.0], "value": 194.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 69.0, 70.0, 71.0, 67.0, 69.0, 80.0, 76.0, 73.0, 68.0], "value": 71.5, "unit": "score"}]}]} 09:54:20 INFO - Return code: 0 09:54:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:54:20 ERROR - # TBPL SUCCESS # 09:54:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:54:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:54:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:54:20 INFO - 2016-09-26 09:54:20.659 screenresolution[1674:10471] starting screenresolution argv=screenresolution get 09:54:20 INFO - 2016-09-26 09:54:20.662 screenresolution[1674:10471] Display 0: 1600x1200x32@60 09:54:20 INFO - 2016-09-26 09:54:20.668 screenresolution[1675:10475] starting screenresolution argv=screenresolution list 09:54:20 INFO - Available Modes on Display 0 09:54:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:54:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:54:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:54:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:54:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:54:20 INFO - Intel Iris: 09:54:20 INFO - Chipset Model: Intel Iris 09:54:20 INFO - Type: GPU 09:54:20 INFO - Bus: Built-In 09:54:20 INFO - VRAM (Dynamic, Max): 1536 MB 09:54:20 INFO - Vendor: Intel (0x8086) 09:54:20 INFO - Device ID: 0x0a2e 09:54:20 INFO - Revision ID: 0x0009 09:54:20 INFO - Displays: 09:54:20 INFO - Display: 09:54:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:54:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:54:20 INFO - Display Serial Number: 1600x1200 60 09:54:20 INFO - Main Display: Yes 09:54:20 INFO - Mirror: Off 09:54:20 INFO - Online: Yes 09:54:20 INFO - Rotation: Supported 09:54:20 INFO - Return code: 0 09:54:20 INFO - Running post-action listener: _resource_record_post_action 09:54:20 INFO - [mozharness: 2016-09-26 16:54:20.906240Z] Finished run-tests step (success) 09:54:20 INFO - Running post-run listener: _resource_record_post_run 09:54:20 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 39041536; Write bytes: 707846656; Read time: 382; Write time: 2008 09:54:20 INFO - TinderboxPrint: CPU usage
54.4% 09:54:20 INFO - TinderboxPrint: I/O read bytes / time
39,041,536 / 382 09:54:20 INFO - TinderboxPrint: I/O write bytes / time
707,846,656 / 2,008 09:54:20 INFO - TinderboxPrint: CPU idle
2,206.0 (45.6%) 09:54:20 INFO - TinderboxPrint: CPU system
976.2 (20.2%) 09:54:20 INFO - TinderboxPrint: CPU user
1,655.5 (34.2%) 09:54:20 INFO - TinderboxPrint: Swap in / out
446,070,784 / 0 09:54:20 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 399491584; Write bytes: 392840704; Read time: 29539; Write time: 653 09:54:20 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 37022208; Write bytes: 298220544; Read time: 359; Write time: 1316 09:54:21 INFO - Running post-run listener: _upload_blobber_files 09:54:21 INFO - Blob upload gear active. 09:54:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:54:21 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 09:54:21 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:54:21 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:54:21 INFO - (blobuploader) - INFO - Open directory for files ... 09:54:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:54:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:54:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:54:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:54:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:54:22 INFO - (blobuploader) - INFO - Done attempting. 09:54:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:54:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:54:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:54:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:54:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:54:23 INFO - (blobuploader) - INFO - Done attempting. 09:54:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:54:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:54:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:54:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:54:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:54:25 INFO - (blobuploader) - INFO - Done attempting. 09:54:25 INFO - (blobuploader) - INFO - Iteration through files over. 09:54:25 INFO - Return code: 0 09:54:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:54:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:54:25 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/302e2d4a8ab987934aea7a7314dee232e618b6de952b4689193be24db1c1e281de3cc425f00eec18c6cb2408aded9119923f751a9e27eb4f236df5da55d37e70", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ea6682f2a36786b813349b355d92df980eea27a4f0607a4d1a7a3f712fff2dc30d0912b7cf9bea3e3d5aaac41a8617f8d87af5ef2cc565a1b714c3c5f7ca8ecc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/43e6e02f788e9594e12128941a175c66aa59b084539d1550e940ff0de8dd8d19de4864f6b9ca4f38378df24ce590df06c16bd91425ea53d3eb1a355ccd9b64a3"} 09:54:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:54:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:54:25 INFO - Contents: 09:54:25 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/302e2d4a8ab987934aea7a7314dee232e618b6de952b4689193be24db1c1e281de3cc425f00eec18c6cb2408aded9119923f751a9e27eb4f236df5da55d37e70", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ea6682f2a36786b813349b355d92df980eea27a4f0607a4d1a7a3f712fff2dc30d0912b7cf9bea3e3d5aaac41a8617f8d87af5ef2cc565a1b714c3c5f7ca8ecc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/43e6e02f788e9594e12128941a175c66aa59b084539d1550e940ff0de8dd8d19de4864f6b9ca4f38378df24ce590df06c16bd91425ea53d3eb1a355ccd9b64a3"} 09:54:25 INFO - Running post-run listener: copy_logs_to_upload_dir 09:54:25 INFO - Copying logs to upload dir... 09:54:25 INFO - mkdir: /builds/slave/test/build/upload/logs 09:54:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.499530 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-09-26 09:54:26.035424) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-26 09:54:26.043281) ========= 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.fEpmAsTJQr/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.uitDbdXuIn/Listeners TMPDIR=/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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/Autoland/sha512/302e2d4a8ab987934aea7a7314dee232e618b6de952b4689193be24db1c1e281de3cc425f00eec18c6cb2408aded9119923f751a9e27eb4f236df5da55d37e70", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ea6682f2a36786b813349b355d92df980eea27a4f0607a4d1a7a3f712fff2dc30d0912b7cf9bea3e3d5aaac41a8617f8d87af5ef2cc565a1b714c3c5f7ca8ecc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/43e6e02f788e9594e12128941a175c66aa59b084539d1550e940ff0de8dd8d19de4864f6b9ca4f38378df24ce590df06c16bd91425ea53d3eb1a355ccd9b64a3"} build_url:https://queue.taskcluster.net/v1/task/M1sX-InQRyWL7FMjniO_HQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011127 build_url: 'https://queue.taskcluster.net/v1/task/M1sX-InQRyWL7FMjniO_HQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/302e2d4a8ab987934aea7a7314dee232e618b6de952b4689193be24db1c1e281de3cc425f00eec18c6cb2408aded9119923f751a9e27eb4f236df5da55d37e70", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ea6682f2a36786b813349b355d92df980eea27a4f0607a4d1a7a3f712fff2dc30d0912b7cf9bea3e3d5aaac41a8617f8d87af5ef2cc565a1b714c3c5f7ca8ecc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/43e6e02f788e9594e12128941a175c66aa59b084539d1550e940ff0de8dd8d19de4864f6b9ca4f38378df24ce590df06c16bd91425ea53d3eb1a355ccd9b64a3"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-26 09:54:26.079478) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 09:54:26.079772) ========= 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.fEpmAsTJQr/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.uitDbdXuIn/Listeners TMPDIR=/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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.004994 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 09:54:26.127632) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-26 09:54:26.130944) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-26 09:54:26.131244) ========= ========= Total master_lag: 0.19 =========