builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0375 starttime: 1485567736.87 results: success (0) buildid: 20170127163321 builduid: 1613f46ce4f7436596f0e5732c09b673 revision: 0766f63202b5fd05043163f0f47ba7d735d61e99 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-27 17:42:16.874178) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-27 17:42:16.874678) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-27 17:42:16.875010) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-27 17:42:16.901201) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 17:42:16.901592) ========= 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.wDeSxdjMY2/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.53h9eZHAzP/Listeners TMPDIR=/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-27 17:42:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 19.0M=0.001s 2017-01-27 17:42:17 (19.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.098759 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 17:42:17.029488) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 17:42:17.030094) ========= 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.wDeSxdjMY2/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.53h9eZHAzP/Listeners TMPDIR=/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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.025831 ========= master_lag: 0.24 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 17:42:17.292385) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-27 17:42:17.292749) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0766f63202b5fd05043163f0f47ba7d735d61e99 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 0766f63202b5fd05043163f0f47ba7d735d61e99 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wDeSxdjMY2/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.53h9eZHAzP/Listeners TMPDIR=/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-27 17:42:17,403 truncating revision to first 12 chars 2017-01-27 17:42:17,404 Setting DEBUG logging. 2017-01-27 17:42:17,404 attempt 1/10 2017-01-27 17:42:17,404 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0766f63202b5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-27 17:42:18,200 unpacking tar archive at: mozilla-central-0766f63202b5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.064739 ========= master_lag: 0.13 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-27 17:42:18.490650) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-27 17:42:18.491123) ========= script_repo_revision: 0766f63202b5fd05043163f0f47ba7d735d61e99 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-27 17:42:18.491535) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 1 secs) (at 2017-01-27 17:42:18.491828) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 1 secs) (at 2017-01-27 17:42:20.048432) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-01-27 17:42:20.048848) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wDeSxdjMY2/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.53h9eZHAzP/Listeners TMPDIR=/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 17:42:20 INFO - MultiFileLogger online at 20170127 17:42:20 in /builds/slave/test 17:42:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 17:42:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:42:20 INFO - {'append_to_log': False, 17:42:20 INFO - 'base_work_dir': '/builds/slave/test', 17:42:20 INFO - 'blob_upload_branch': 'Firefox', 17:42:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:42:20 INFO - 'branch': 'Firefox', 17:42:20 INFO - 'buildbot_json_path': 'buildprops.json', 17:42:20 INFO - 'config_files': ('talos/mac_config.py',), 17:42:20 INFO - 'default_actions': ('clobber', 17:42:20 INFO - 'read-buildbot-config', 17:42:20 INFO - 'download-and-extract', 17:42:20 INFO - 'populate-webroot', 17:42:20 INFO - 'create-virtualenv', 17:42:20 INFO - 'install', 17:42:20 INFO - 'run-tests'), 17:42:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:42:20 INFO - 'download_minidump_stackwalk': True, 17:42:20 INFO - 'download_symbols': 'ondemand', 17:42:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:42:20 INFO - 'tooltool.py': '/tools/tooltool.py', 17:42:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:42:20 INFO - '/tools/misc-python/virtualenv.py')}, 17:42:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:42:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:42:20 INFO - 'installer_path': 'installer.exe', 17:42:20 INFO - 'log_level': 'info', 17:42:20 INFO - 'log_name': 'talos', 17:42:20 INFO - 'log_to_console': True, 17:42:20 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:42:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:42:20 INFO - 'opt_config_files': (), 17:42:20 INFO - 'pip_index': False, 17:42:20 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:42:20 INFO - 'cmd': ('bash', 17:42:20 INFO - '-c', 17:42:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:42:20 INFO - 'enabled': True, 17:42:20 INFO - 'halt_on_failure': False, 17:42:20 INFO - 'name': 'check_screen_resolution'},), 17:42:20 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:42:20 INFO - 'cmd': ('bash', 17:42:20 INFO - '-c', 17:42:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:42:20 INFO - 'enabled': True, 17:42:20 INFO - 'halt_on_failure': False, 17:42:20 INFO - 'name': 'check_screen_resolution'},), 17:42:20 INFO - 'run_cmd_checks_enabled': True, 17:42:20 INFO - 'sps_profile': False, 17:42:20 INFO - 'sps_profile_interval': 0, 17:42:20 INFO - 'suite': 'dromaeojs-e10s', 17:42:20 INFO - 'system_bits': '32', 17:42:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:42:20 INFO - 'title': 't-yosemite-r7-0375', 17:42:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:42:20 INFO - 'use_talos_json': True, 17:42:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:42:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:42:20 INFO - 'work_dir': 'build'} 17:42:20 INFO - [mozharness: 2017-01-28 01:42:20.262318Z] Running clobber step. 17:42:20 INFO - Running pre-action listener: _resource_record_pre_action 17:42:20 INFO - Running main action method: clobber 17:42:20 INFO - rmtree: /builds/slave/test/build 17:42:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:42:22 INFO - Running post-action listener: _resource_record_post_action 17:42:22 INFO - [mozharness: 2017-01-28 01:42:22.741153Z] Finished clobber step (success) 17:42:22 INFO - [mozharness: 2017-01-28 01:42:22.741282Z] Running read-buildbot-config step. 17:42:22 INFO - Running pre-action listener: _resource_record_pre_action 17:42:22 INFO - Running main action method: read_buildbot_config 17:42:22 INFO - Using buildbot properties: 17:42:22 INFO - { 17:42:22 INFO - "project": "", 17:42:22 INFO - "product": "firefox", 17:42:22 INFO - "script_repo_revision": "production", 17:42:22 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 17:42:22 INFO - "repository": "", 17:42:22 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 17:42:22 INFO - "buildid": "20170127163321", 17:42:22 INFO - "pgo_build": "False", 17:42:22 INFO - "basedir": "/builds/slave/test", 17:42:22 INFO - "buildnumber": 28, 17:42:22 INFO - "slavename": "t-yosemite-r7-0375", 17:42:22 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 17:42:22 INFO - "platform": "yosemite_r7", 17:42:22 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 17:42:22 INFO - "branch": "mozilla-central", 17:42:22 INFO - "repo_path": "mozilla-central", 17:42:22 INFO - "revision": "0766f63202b5fd05043163f0f47ba7d735d61e99", 17:42:22 INFO - "stage_platform": "macosx64", 17:42:22 INFO - "builduid": "1613f46ce4f7436596f0e5732c09b673", 17:42:22 INFO - "slavebuilddir": "test" 17:42:22 INFO - } 17:42:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/Nk_XgKDvSY2W-86vxrQemQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 17:42:22 INFO - Running post-action listener: _resource_record_post_action 17:42:22 INFO - [mozharness: 2017-01-28 01:42:22.744734Z] Finished read-buildbot-config step (success) 17:42:22 INFO - [mozharness: 2017-01-28 01:42:22.744858Z] Running download-and-extract step. 17:42:22 INFO - Running pre-action listener: _resource_record_pre_action 17:42:22 INFO - Running main action method: download_and_extract 17:42:22 INFO - mkdir: /builds/slave/test/build/tests 17:42:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:22 INFO - trying https://queue.taskcluster.net/v1/task/Nk_XgKDvSY2W-86vxrQemQ/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 17:42:22 INFO - Downloading https://queue.taskcluster.net/v1/task/Nk_XgKDvSY2W-86vxrQemQ/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 17:42:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Nk_XgKDvSY2W-86vxrQemQ/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 17:42:24 INFO - Downloaded 1199 bytes. 17:42:24 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 17:42:24 INFO - Using the following test package requirements: 17:42:24 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 17:42:24 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 17:42:24 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 17:42:24 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 17:42:24 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 17:42:24 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 17:42:24 INFO - u'jsshell-mac.zip'], 17:42:24 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 17:42:24 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 17:42:24 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 17:42:24 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 17:42:24 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 17:42:24 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 17:42:24 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 17:42:24 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 17:42:24 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 17:42:24 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 17:42:24 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 17:42:24 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:42:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Nk_XgKDvSY2W-86vxrQemQ/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 17:42:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Nk_XgKDvSY2W-86vxrQemQ/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:42:24 INFO - Fetch https://queue.taskcluster.net/v1/task/Nk_XgKDvSY2W-86vxrQemQ/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 17:42:24 INFO - Expected file size: 16361123 17:42:24 INFO - Obtained file size: 16361123 17:42:31 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 17:42:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Nk_XgKDvSY2W-86vxrQemQ/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 17:42:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Nk_XgKDvSY2W-86vxrQemQ/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:42:31 INFO - Fetch https://queue.taskcluster.net/v1/task/Nk_XgKDvSY2W-86vxrQemQ/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 17:42:32 INFO - Expected file size: 16361123 17:42:32 INFO - Obtained file size: 16361123 17:42:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Nk_XgKDvSY2W-86vxrQemQ/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 17:42:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Nk_XgKDvSY2W-86vxrQemQ/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 17:42:38 INFO - Fetch https://queue.taskcluster.net/v1/task/Nk_XgKDvSY2W-86vxrQemQ/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 17:42:39 INFO - Expected file size: 14403466 17:42:39 INFO - Obtained file size: 14403466 17:42:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:39 INFO - trying https://queue.taskcluster.net/v1/task/Nk_XgKDvSY2W-86vxrQemQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 17:42:39 INFO - Downloading https://queue.taskcluster.net/v1/task/Nk_XgKDvSY2W-86vxrQemQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 17:42:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Nk_XgKDvSY2W-86vxrQemQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 17:42:42 INFO - Downloaded 70057230 bytes. 17:42:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Nk_XgKDvSY2W-86vxrQemQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 17:42:42 INFO - mkdir: /builds/slave/test/properties 17:42:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:42:42 INFO - Writing to file /builds/slave/test/properties/build_url 17:42:42 INFO - Contents: 17:42:42 INFO - build_url:https://queue.taskcluster.net/v1/task/Nk_XgKDvSY2W-86vxrQemQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 17:42:43 INFO - Running post-action listener: _resource_record_post_action 17:42:43 INFO - Running post-action listener: set_extra_try_arguments 17:42:43 INFO - [mozharness: 2017-01-28 01:42:43.467152Z] Finished download-and-extract step (success) 17:42:43 INFO - [mozharness: 2017-01-28 01:42:43.467283Z] Running populate-webroot step. 17:42:43 INFO - Running pre-action listener: _resource_record_pre_action 17:42:43 INFO - Running main action method: populate_webroot 17:42:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:42:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:42:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:42:43 INFO - '--tppagecycles', 17:42:43 INFO - '7'], 17:42:43 INFO - 'tests': ['tsvgm']}}, 17:42:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:42:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:42:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:42:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:42:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:42:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:42:43 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:42:43 INFO - 'talos_options': ['--disable-e10s'], 17:42:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:42:43 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:42:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:42:43 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:42:43 INFO - 'talos_options': ['--disable-e10s'], 17:42:43 INFO - 'tests': ['damp', 'tps']}, 17:42:43 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:42:43 INFO - 'tests': ['damp', 'tps']}, 17:42:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:42:43 INFO - 'tests': ['dromaeo_dom']}, 17:42:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:42:43 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:42:43 INFO - 'tests': ['basic_compositor_video']}, 17:42:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:42:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:42:43 INFO - 'tests': ['a11yr', 17:42:43 INFO - 'ts_paint', 17:42:43 INFO - 'tpaint', 17:42:43 INFO - 'sessionrestore', 17:42:43 INFO - 'sessionrestore_no_auto_restore', 17:42:43 INFO - 'tabpaint']}, 17:42:43 INFO - 'other-e10s': {'tests': ['a11yr', 17:42:43 INFO - 'ts_paint', 17:42:43 INFO - 'tpaint', 17:42:43 INFO - 'sessionrestore', 17:42:43 INFO - 'sessionrestore_no_auto_restore', 17:42:43 INFO - 'tabpaint']}, 17:42:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:42:43 INFO - 'ts_paint', 17:42:43 INFO - 'tpaint', 17:42:43 INFO - 'sessionrestore', 17:42:43 INFO - 'sessionrestore_no_auto_restore', 17:42:43 INFO - 'tabpaint']}, 17:42:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:42:43 INFO - 'ts_paint', 17:42:43 INFO - 'tpaint', 17:42:43 INFO - 'sessionrestore', 17:42:43 INFO - 'sessionrestore_no_auto_restore', 17:42:43 INFO - 'tabpaint']}, 17:42:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:42:43 INFO - 'tests': ['a11yr', 17:42:43 INFO - 'ts_paint', 17:42:43 INFO - 'tpaint', 17:42:43 INFO - 'sessionrestore', 17:42:43 INFO - 'sessionrestore_no_auto_restore', 17:42:43 INFO - 'tabpaint']}, 17:42:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:42:43 INFO - 'tests': ['a11yr', 17:42:43 INFO - 'ts_paint', 17:42:43 INFO - 'tpaint', 17:42:43 INFO - 'sessionrestore', 17:42:43 INFO - 'sessionrestore_no_auto_restore', 17:42:43 INFO - 'tabpaint']}, 17:42:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:42:43 INFO - 'tests': ['tsvgx', 17:42:43 INFO - 'tsvgr_opacity', 17:42:43 INFO - 'tart', 17:42:43 INFO - 'tscrollx', 17:42:43 INFO - 'cart', 17:42:43 INFO - 'tsvg_static']}, 17:42:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:42:43 INFO - 'tsvgr_opacity', 17:42:43 INFO - 'tart', 17:42:43 INFO - 'tscrollx', 17:42:43 INFO - 'cart', 17:42:43 INFO - 'tsvg_static']}, 17:42:43 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:42:43 INFO - 'talos_options': ['--disable-e10s'], 17:42:43 INFO - 'tests': ['tp5o']}, 17:42:43 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:42:43 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:42:43 INFO - 'talos_options': ['--disable-e10s', 17:42:43 INFO - '--xperf_path', 17:42:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:42:43 INFO - 'tests': ['tp5n']}, 17:42:43 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:42:43 INFO - 'talos_options': ['--xperf_path', 17:42:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:42:43 INFO - 'tests': ['tp5n']}}, 17:42:43 INFO - 'talos.zip': {'path': '', 17:42:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:42:43 INFO - Running post-action listener: _resource_record_post_action 17:42:43 INFO - [mozharness: 2017-01-28 01:42:43.485908Z] Finished populate-webroot step (success) 17:42:43 INFO - [mozharness: 2017-01-28 01:42:43.486037Z] Running create-virtualenv step. 17:42:43 INFO - Running pre-action listener: _resource_record_pre_action 17:42:43 INFO - Running main action method: create_virtualenv 17:42:43 INFO - Creating virtualenv /builds/slave/test/build/venv 17:42:43 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:42:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:42:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:42:43 INFO - Using real prefix '/tools/python27' 17:42:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:42:44 INFO - Installing distribute.............................................................................................................................................................................................done. 17:42:47 INFO - Installing pip.................done. 17:42:47 INFO - Return code: 0 17:42:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:42:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:42:47 INFO - Reading from file tmpfile_stdout 17:42:47 INFO - Output received: 17:42:47 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) 17:42:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:42:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d409b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d40c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa702c7ad90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1e7d30>, '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 0x10d10edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d1dcbe8>, '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.wDeSxdjMY2/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.53h9eZHAzP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:42:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:42:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:42:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wDeSxdjMY2/Render', 17:42:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:42:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:42:47 INFO - 'HOME': '/Users/cltbld', 17:42:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:42:47 INFO - 'LOGNAME': 'cltbld', 17:42:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:47 INFO - 'MOZ_NO_REMOTE': '1', 17:42:47 INFO - 'NO_EM_RESTART': '1', 17:42:47 INFO - 'PAGER': '/bin/cat', 17:42:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:42:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:47 INFO - 'PWD': '/builds/slave/test', 17:42:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:42:47 INFO - 'SHELL': '/bin/bash', 17:42:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.53h9eZHAzP/Listeners', 17:42:47 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 17:42:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:42:47 INFO - 'USER': 'cltbld', 17:42:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:42:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:42:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:47 INFO - 'XPC_FLAGS': '0x0', 17:42:47 INFO - 'XPC_SERVICE_NAME': '0', 17:42:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:42:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:47 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:42:47 INFO - Cleaning up... 17:42:47 INFO - Return code: 0 17:42:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:42:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d409b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d40c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa702c7ad90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1e7d30>, '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 0x10d10edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d1dcbe8>, '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.wDeSxdjMY2/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.53h9eZHAzP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:42:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:42:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:42:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wDeSxdjMY2/Render', 17:42:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:42:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:42:47 INFO - 'HOME': '/Users/cltbld', 17:42:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:42:47 INFO - 'LOGNAME': 'cltbld', 17:42:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:47 INFO - 'MOZ_NO_REMOTE': '1', 17:42:47 INFO - 'NO_EM_RESTART': '1', 17:42:47 INFO - 'PAGER': '/bin/cat', 17:42:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:42:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:47 INFO - 'PWD': '/builds/slave/test', 17:42:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:42:47 INFO - 'SHELL': '/bin/bash', 17:42:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.53h9eZHAzP/Listeners', 17:42:47 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 17:42:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:42:47 INFO - 'USER': 'cltbld', 17:42:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:42:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:42:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:47 INFO - 'XPC_FLAGS': '0x0', 17:42:47 INFO - 'XPC_SERVICE_NAME': '0', 17:42:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:42:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:47 INFO - Downloading/unpacking psutil>=3.1.1 17:42:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:42:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:42:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:42:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:42:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:42:51 INFO - Installing collected packages: psutil 17:42:51 INFO - Running setup.py install for psutil 17:42:51 INFO - building 'psutil._psutil_osx' extension 17:42:51 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 17:42:52 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 17:42:52 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 17:42:52 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 17:42:52 INFO - building 'psutil._psutil_posix' extension 17:42:52 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 17:42:52 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:42:52 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:42:52 INFO - ^ 17:42:52 INFO - 1 warning generated. 17:42:52 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 17:42:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:42:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:42:52 INFO - Successfully installed psutil 17:42:52 INFO - Cleaning up... 17:42:52 INFO - Return code: 0 17:42:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:42:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:42:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:52 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 0x10d409b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d40c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa702c7ad90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1e7d30>, '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 0x10d10edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d1dcbe8>, '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.wDeSxdjMY2/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.53h9eZHAzP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:42:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:42:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:42:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wDeSxdjMY2/Render', 17:42:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:42:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:42:52 INFO - 'HOME': '/Users/cltbld', 17:42:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:42:52 INFO - 'LOGNAME': 'cltbld', 17:42:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:52 INFO - 'MOZ_NO_REMOTE': '1', 17:42:52 INFO - 'NO_EM_RESTART': '1', 17:42:52 INFO - 'PAGER': '/bin/cat', 17:42:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:42:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:52 INFO - 'PWD': '/builds/slave/test', 17:42:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:42:52 INFO - 'SHELL': '/bin/bash', 17:42:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.53h9eZHAzP/Listeners', 17:42:52 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 17:42:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:42:52 INFO - 'USER': 'cltbld', 17:42:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:42:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:42:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:52 INFO - 'XPC_FLAGS': '0x0', 17:42:52 INFO - 'XPC_SERVICE_NAME': '0', 17:42:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:42:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:42:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:42:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:42:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:42:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:42:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:42:55 INFO - Installing collected packages: mozsystemmonitor 17:42:55 INFO - Running setup.py install for mozsystemmonitor 17:42:55 INFO - Successfully installed mozsystemmonitor 17:42:55 INFO - Cleaning up... 17:42:55 INFO - Return code: 0 17:42:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:42: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')]} 17:42:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42: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')]} 17:42:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42: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', '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 0x10d409b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d40c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa702c7ad90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1e7d30>, '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 0x10d10edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d1dcbe8>, '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.wDeSxdjMY2/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.53h9eZHAzP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:42: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:42: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 jsonschema==2.5.1 17:42:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wDeSxdjMY2/Render', 17:42:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:42:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:42:55 INFO - 'HOME': '/Users/cltbld', 17:42:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:42:55 INFO - 'LOGNAME': 'cltbld', 17:42:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:55 INFO - 'MOZ_NO_REMOTE': '1', 17:42:55 INFO - 'NO_EM_RESTART': '1', 17:42:55 INFO - 'PAGER': '/bin/cat', 17:42:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:42:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:55 INFO - 'PWD': '/builds/slave/test', 17:42:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:42:55 INFO - 'SHELL': '/bin/bash', 17:42:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.53h9eZHAzP/Listeners', 17:42:55 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 17:42:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:42:55 INFO - 'USER': 'cltbld', 17:42:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:42:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:42:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:55 INFO - 'XPC_FLAGS': '0x0', 17:42:55 INFO - 'XPC_SERVICE_NAME': '0', 17:42:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:42:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:56 INFO - Downloading/unpacking jsonschema==2.5.1 17:42:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:42:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:42:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:42:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:42:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:42:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:42: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 17:42: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 17:42: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 17:42: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 17:42: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 17:42: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 17:42:59 INFO - Downloading functools32-3.2.3-2.tar.gz 17:42:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:42:59 INFO - warning: no files found matching '*.txt' 17:42:59 INFO - no previously-included directories found matching 'build' 17:42:59 INFO - no previously-included directories found matching 'dist' 17:42:59 INFO - no previously-included directories found matching '.git*' 17:42:59 INFO - Installing collected packages: jsonschema, functools32 17:42:59 INFO - Running setup.py install for functools32 17:42:59 INFO - warning: no files found matching '*.txt' 17:42:59 INFO - no previously-included directories found matching 'build' 17:42:59 INFO - no previously-included directories found matching 'dist' 17:42:59 INFO - no previously-included directories found matching '.git*' 17:42:59 INFO - Successfully installed jsonschema functools32 17:42:59 INFO - Cleaning up... 17:42:59 INFO - Return code: 0 17:42:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:42: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')]} 17:42:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42: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')]} 17:42:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:59 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 0x10d409b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d40c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa702c7ad90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1e7d30>, '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 0x10d10edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d1dcbe8>, '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.wDeSxdjMY2/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.53h9eZHAzP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:42:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:42:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:42:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wDeSxdjMY2/Render', 17:42:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:42:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:42:59 INFO - 'HOME': '/Users/cltbld', 17:42:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:42:59 INFO - 'LOGNAME': 'cltbld', 17:42:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:59 INFO - 'MOZ_NO_REMOTE': '1', 17:42:59 INFO - 'NO_EM_RESTART': '1', 17:42:59 INFO - 'PAGER': '/bin/cat', 17:42:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:42:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:59 INFO - 'PWD': '/builds/slave/test', 17:42:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:42:59 INFO - 'SHELL': '/bin/bash', 17:42:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.53h9eZHAzP/Listeners', 17:42:59 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 17:42:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:42:59 INFO - 'USER': 'cltbld', 17:42:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:42:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:42:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:59 INFO - 'XPC_FLAGS': '0x0', 17:42:59 INFO - 'XPC_SERVICE_NAME': '0', 17:42:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:42:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:42:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:42:59 INFO - Cleaning up... 17:42:59 INFO - Return code: 0 17:42:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:42: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')]} 17:42:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:42:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42: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')]} 17:42:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:42:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:42:59 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 0x10d409b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d40c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa702c7ad90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1e7d30>, '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 0x10d10edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d1dcbe8>, '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.wDeSxdjMY2/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.53h9eZHAzP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:42:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:42:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:42:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wDeSxdjMY2/Render', 17:42:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:42:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:42:59 INFO - 'HOME': '/Users/cltbld', 17:42:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:42:59 INFO - 'LOGNAME': 'cltbld', 17:42:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:42:59 INFO - 'MOZ_NO_REMOTE': '1', 17:42:59 INFO - 'NO_EM_RESTART': '1', 17:42:59 INFO - 'PAGER': '/bin/cat', 17:42:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:42:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:42:59 INFO - 'PWD': '/builds/slave/test', 17:42:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:42:59 INFO - 'SHELL': '/bin/bash', 17:42:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.53h9eZHAzP/Listeners', 17:42:59 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 17:42:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:42:59 INFO - 'USER': 'cltbld', 17:42:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:42:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:42:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:42:59 INFO - 'XPC_FLAGS': '0x0', 17:42:59 INFO - 'XPC_SERVICE_NAME': '0', 17:42:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:43:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:00 INFO - Downloading/unpacking blobuploader==1.2.4 17:43:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:43:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:43:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:02 INFO - Downloading blobuploader-1.2.4.tar.gz 17:43:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:43:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:43:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:43:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:43:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:43:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:43:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:43:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:43:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:04 INFO - Downloading docopt-0.6.1.tar.gz 17:43:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:43:04 INFO - Installing collected packages: blobuploader, requests, docopt 17:43:04 INFO - Running setup.py install for blobuploader 17:43:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:43:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:43:04 INFO - Running setup.py install for requests 17:43:04 INFO - Running setup.py install for docopt 17:43:04 INFO - Successfully installed blobuploader requests docopt 17:43:04 INFO - Cleaning up... 17:43:04 INFO - Return code: 0 17:43:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:43:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:05 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 0x10d409b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d40c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa702c7ad90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1e7d30>, '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 0x10d10edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d1dcbe8>, '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.wDeSxdjMY2/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.53h9eZHAzP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:43:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:43:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:43:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wDeSxdjMY2/Render', 17:43:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:43:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:43:05 INFO - 'HOME': '/Users/cltbld', 17:43:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:43:05 INFO - 'LOGNAME': 'cltbld', 17:43:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:05 INFO - 'MOZ_NO_REMOTE': '1', 17:43:05 INFO - 'NO_EM_RESTART': '1', 17:43:05 INFO - 'PAGER': '/bin/cat', 17:43:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:43:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:05 INFO - 'PWD': '/builds/slave/test', 17:43:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:43:05 INFO - 'SHELL': '/bin/bash', 17:43:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.53h9eZHAzP/Listeners', 17:43:05 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 17:43:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:43:05 INFO - 'USER': 'cltbld', 17:43:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:43:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:43:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:05 INFO - 'XPC_FLAGS': '0x0', 17:43:05 INFO - 'XPC_SERVICE_NAME': '0', 17:43:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:43:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:43:05 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-BZxWmk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:43:05 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-5IfmGo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:43:05 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-nMWz1M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:43:05 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-ZadmFZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:43:05 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-FVQBUU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:43:05 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-_7jJLq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:43:05 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-Fan3cH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:43:05 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-5oFGLh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:43:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:43:06 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-jvdrxv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:43:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:43:06 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-Qw7X6X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:43:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:43:06 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-M6TPqB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:43:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:43:06 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-u5r7M3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:43:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:43:06 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-7SpkRf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:43:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:43:06 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-r4SER1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:43:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:43:06 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-G0yRZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:43:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:43:06 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-yvgL9h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:43:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:43:06 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-b9pdd_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:43:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:43:07 INFO - Running setup.py install for manifestparser 17:43:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:43:07 INFO - Running setup.py install for mozcrash 17:43:07 INFO - Running setup.py install for mozdebug 17:43:07 INFO - Running setup.py install for mozdevice 17:43:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:43:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:43:07 INFO - Running setup.py install for mozfile 17:43:07 INFO - Running setup.py install for mozhttpd 17:43:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:43:07 INFO - Running setup.py install for mozinfo 17:43:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:43:08 INFO - Running setup.py install for mozInstall 17:43:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:43:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:43:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:43:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:43:08 INFO - Running setup.py install for mozleak 17:43:08 INFO - Running setup.py install for mozlog 17:43:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:43:08 INFO - Running setup.py install for moznetwork 17:43:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:43:08 INFO - Running setup.py install for mozprocess 17:43:08 INFO - Running setup.py install for mozprofile 17:43:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:43:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:43:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:43:08 INFO - Running setup.py install for mozrunner 17:43:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:43:09 INFO - Running setup.py install for mozscreenshot 17:43:09 INFO - Running setup.py install for moztest 17:43:09 INFO - Running setup.py install for mozversion 17:43:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:43:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:43:09 INFO - Cleaning up... 17:43:09 INFO - Return code: 0 17:43:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:43: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')]} 17:43:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43: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')]} 17:43:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:09 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 0x10d409b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d40c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa702c7ad90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1e7d30>, '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 0x10d10edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d1dcbe8>, '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.wDeSxdjMY2/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.53h9eZHAzP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:43:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:43:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:43:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wDeSxdjMY2/Render', 17:43:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:43:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:43:09 INFO - 'HOME': '/Users/cltbld', 17:43:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:43:09 INFO - 'LOGNAME': 'cltbld', 17:43:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:09 INFO - 'MOZ_NO_REMOTE': '1', 17:43:09 INFO - 'NO_EM_RESTART': '1', 17:43:09 INFO - 'PAGER': '/bin/cat', 17:43:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:43:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:09 INFO - 'PWD': '/builds/slave/test', 17:43:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:43:09 INFO - 'SHELL': '/bin/bash', 17:43:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.53h9eZHAzP/Listeners', 17:43:09 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 17:43:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:43:09 INFO - 'USER': 'cltbld', 17:43:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:43:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:43:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:09 INFO - 'XPC_FLAGS': '0x0', 17:43:09 INFO - 'XPC_SERVICE_NAME': '0', 17:43:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:43:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:43:09 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-Ta7mJc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:43:09 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:43:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:43:09 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-euXew9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:43:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:43:10 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-_VjGdq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:43:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:43:10 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-en7TAL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:43:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:43:10 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-hFHwWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:43:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:43:10 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-JbOelP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:43:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 17:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:43:10 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-JrQajE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:43:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:43:10 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-D0mvei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:43:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:43:10 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-8wSlAn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:43:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:43:10 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-MUo3Lq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:43:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:43:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:43:10 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-SPYUQQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:43:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:43:11 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-JDIPEH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:43:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:43:11 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-YNjbWl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:43:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:43:11 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-KHAid5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:43:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:43:11 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-wLtQ54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:43:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:43:11 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-pbyBj0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:43:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:43:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:43:11 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-lnBTgG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:43:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:43:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:43:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:43:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:43:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:43:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:43:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:43:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:43:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:43:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:14 INFO - Downloading blessings-1.6.tar.gz 17:43:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:43:14 INFO - Installing collected packages: blessings 17:43:14 INFO - Running setup.py install for blessings 17:43:14 INFO - Successfully installed blessings 17:43:14 INFO - Cleaning up... 17:43:14 INFO - Return code: 0 17:43:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:43:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:43:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:43:14 INFO - Reading from file tmpfile_stdout 17:43:14 INFO - Current package versions: 17:43:14 INFO - blessings == 1.6 17:43:14 INFO - blobuploader == 1.2.4 17:43:14 INFO - docopt == 0.6.1 17:43:14 INFO - functools32 == 3.2.3-2 17:43:14 INFO - jsonschema == 2.5.1 17:43:14 INFO - manifestparser == 1.1 17:43:14 INFO - mozInstall == 1.12 17:43:14 INFO - mozcrash == 1.0 17:43:14 INFO - mozdebug == 0.1 17:43:14 INFO - mozdevice == 0.49 17:43:14 INFO - mozfile == 1.2 17:43:14 INFO - mozhttpd == 0.7 17:43:14 INFO - mozinfo == 0.9 17:43:14 INFO - mozleak == 0.1 17:43:14 INFO - mozlog == 3.4 17:43:14 INFO - moznetwork == 0.27 17:43:14 INFO - mozprocess == 0.24 17:43:14 INFO - mozprofile == 0.28 17:43:14 INFO - mozrunner == 6.13 17:43:14 INFO - mozscreenshot == 0.1 17:43:14 INFO - mozsystemmonitor == 0.3 17:43:14 INFO - moztest == 0.8 17:43:14 INFO - mozversion == 1.4 17:43:14 INFO - psutil == 3.1.1 17:43:14 INFO - requests == 1.2.3 17:43:14 INFO - wsgiref == 0.1.2 17:43:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:43:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:15 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 0x10d409b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d40c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa702c7ad90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1e7d30>, '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 0x10d10edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d1dcbe8>, '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.wDeSxdjMY2/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.53h9eZHAzP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:43:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:43:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:43:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wDeSxdjMY2/Render', 17:43:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:43:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:43:15 INFO - 'HOME': '/Users/cltbld', 17:43:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:43:15 INFO - 'LOGNAME': 'cltbld', 17:43:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:15 INFO - 'MOZ_NO_REMOTE': '1', 17:43:15 INFO - 'NO_EM_RESTART': '1', 17:43:15 INFO - 'PAGER': '/bin/cat', 17:43:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:43:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:15 INFO - 'PWD': '/builds/slave/test', 17:43:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:43:15 INFO - 'SHELL': '/bin/bash', 17:43:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.53h9eZHAzP/Listeners', 17:43:15 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 17:43:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:43:15 INFO - 'USER': 'cltbld', 17:43:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:43:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:43:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:15 INFO - 'XPC_FLAGS': '0x0', 17:43:15 INFO - 'XPC_SERVICE_NAME': '0', 17:43:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:43:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:43:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:43:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:43:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:43:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:43:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:43:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:43:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:43:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:43:15 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:43:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:43:15 INFO - Cleaning up... 17:43:15 INFO - Return code: 0 17:43:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:43:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:15 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 0x10d409b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d40c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa702c7ad90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1e7d30>, '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 0x10d10edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d1dcbe8>, '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.wDeSxdjMY2/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.53h9eZHAzP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:43:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:43:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:43:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wDeSxdjMY2/Render', 17:43:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:43:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:43:15 INFO - 'HOME': '/Users/cltbld', 17:43:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:43:15 INFO - 'LOGNAME': 'cltbld', 17:43:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:15 INFO - 'MOZ_NO_REMOTE': '1', 17:43:15 INFO - 'NO_EM_RESTART': '1', 17:43:15 INFO - 'PAGER': '/bin/cat', 17:43:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:43:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:15 INFO - 'PWD': '/builds/slave/test', 17:43:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:43:15 INFO - 'SHELL': '/bin/bash', 17:43:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.53h9eZHAzP/Listeners', 17:43:15 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 17:43:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:43:15 INFO - 'USER': 'cltbld', 17:43:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:43:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:43:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:15 INFO - 'XPC_FLAGS': '0x0', 17:43:15 INFO - 'XPC_SERVICE_NAME': '0', 17:43:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:43:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:43:15 INFO - Cleaning up... 17:43:15 INFO - Return code: 0 17:43:15 INFO - Running post-action listener: _resource_record_post_action 17:43:15 INFO - Running post-action listener: _start_resource_monitoring 17:43:15 INFO - Starting resource monitoring. 17:43:15 INFO - [mozharness: 2017-01-28 01:43:15.861797Z] Finished create-virtualenv step (success) 17:43:15 INFO - [mozharness: 2017-01-28 01:43:15.862578Z] Running install step. 17:43:15 INFO - Running pre-action listener: _resource_record_pre_action 17:43:15 INFO - Running main action method: install 17:43:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:43:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:43:16 INFO - Reading from file tmpfile_stdout 17:43:16 INFO - Detecting whether we're running mozinstall >=1.0... 17:43:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:43:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:43:16 INFO - Reading from file tmpfile_stdout 17:43:16 INFO - Output received: 17:43:16 INFO - Usage: mozinstall [options] installer 17:43:16 INFO - Options: 17:43:16 INFO - -h, --help show this help message and exit 17:43:16 INFO - -d DEST, --destination=DEST 17:43:16 INFO - Directory to install application into. [default: 17:43:16 INFO - "/builds/slave/test"] 17:43:16 INFO - --app=APP Application being installed. [default: firefox] 17:43:16 INFO - mkdir: /builds/slave/test/build/application 17:43:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 17:43:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 17:43:37 INFO - Reading from file tmpfile_stdout 17:43:37 INFO - Output received: 17:43:37 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:43:37 INFO - Running post-action listener: _resource_record_post_action 17:43:37 INFO - [mozharness: 2017-01-28 01:43:37.896130Z] Finished install step (success) 17:43:37 INFO - [mozharness: 2017-01-28 01:43:37.896283Z] Running run-tests step. 17:43:37 INFO - Running pre-action listener: _resource_record_pre_action 17:43:37 INFO - Running main action method: run_tests 17:43:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:43:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:43:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:43:37 INFO - 2017-01-27 17:43:37.910 screenresolution[1621:7396] starting screenresolution argv=screenresolution get 17:43:37 INFO - 2017-01-27 17:43:37.913 screenresolution[1621:7396] Display 0: 1600x1200x32@60 17:43:37 INFO - 2017-01-27 17:43:37.919 screenresolution[1622:7399] starting screenresolution argv=screenresolution list 17:43:37 INFO - Available Modes on Display 0 17:43:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:43:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:43:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:43:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:43:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:43:38 INFO - Intel Iris: 17:43:38 INFO - Chipset Model: Intel Iris 17:43:38 INFO - Type: GPU 17:43:38 INFO - Bus: Built-In 17:43:38 INFO - VRAM (Dynamic, Max): 1536 MB 17:43:38 INFO - Vendor: Intel (0x8086) 17:43:38 INFO - Device ID: 0x0a2e 17:43:38 INFO - Revision ID: 0x0009 17:43:38 INFO - Displays: 17:43:38 INFO - Display: 17:43:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:43:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:43:38 INFO - Display Serial Number: 1600x1200 60 17:43:38 INFO - Main Display: Yes 17:43:38 INFO - Mirror: Off 17:43:38 INFO - Online: Yes 17:43:38 INFO - Rotation: Supported 17:43:38 INFO - Return code: 0 17:43:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:43:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:43:38 INFO - Python 2.7.3 17:43:38 INFO - Return code: 0 17:43:38 INFO - grabbing minidump binary from tooltool 17:43:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:43:38 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 0x10d1e7d30>, '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 0x10d10edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d1dcbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:43:38 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 17:43:38 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 17:43:38 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 17:43:38 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:43:38 INFO - Return code: 0 17:43:38 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:43:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:43:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:43:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:43:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:43:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Nk_XgKDvSY2W-86vxrQemQ/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0375', '--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 17:43:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Nk_XgKDvSY2W-86vxrQemQ/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0375 --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 17:43:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wDeSxdjMY2/Render', 17:43:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:43:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:43:38 INFO - 'HOME': '/Users/cltbld', 17:43:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:43:38 INFO - 'LOGNAME': 'cltbld', 17:43:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:43:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:43:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:38 INFO - 'MOZ_NO_REMOTE': '1', 17:43:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:43:38 INFO - 'NO_EM_RESTART': '1', 17:43:38 INFO - 'PAGER': '/bin/cat', 17:43:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:43:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:38 INFO - 'PWD': '/builds/slave/test', 17:43:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:43:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:43:38 INFO - 'SHELL': '/bin/bash', 17:43:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.53h9eZHAzP/Listeners', 17:43:38 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 17:43:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:43:38 INFO - 'USER': 'cltbld', 17:43:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:43:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:43:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:38 INFO - 'XPC_FLAGS': '0x0', 17:43:38 INFO - 'XPC_SERVICE_NAME': '0', 17:43:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:43:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Nk_XgKDvSY2W-86vxrQemQ/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0375', '--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 17:43:38 INFO - mozversion application_buildid: 20170127163321 17:43:38 INFO - mozversion application_changeset: 0766f63202b5fd05043163f0f47ba7d735d61e99 17:43:38 INFO - mozversion application_display_name: Nightly 17:43:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:43:38 INFO - mozversion application_name: Firefox 17:43:38 INFO - mozversion application_remotingname: firefox 17:43:38 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:43:38 INFO - mozversion application_vendor: Mozilla 17:43:38 INFO - mozversion application_version: 54.0a1 17:43:38 INFO - mozversion platform_buildid: 20170127163321 17:43:38 INFO - mozversion platform_changeset: 0766f63202b5fd05043163f0f47ba7d735d61e99 17:43:38 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:43:38 INFO - mozversion platform_version: 54.0a1 17:43:38 INFO - using testdate: 1485567818 17:43:38 INFO - actual date: 1485567818 17:43:38 INFO - starting webserver on 'localhost:49248' 17:43:38 INFO - SUITE-START | Running 2 tests 17:43:38 INFO - TEST-START | dromaeo_css 17:43:38 INFO - operating with platform_type : mac_ 17:43:38 INFO - Initialising browser for dromaeo_css test... 17:43:38 INFO - TEST-INFO | started process 1632 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/tmpP_5kIk/profile http://localhost:49248/getInfo.html) 17:43:41 INFO - PROCESS | 1632 | 2017-01-27 17:43:41.510 plugin-container[1634:7560] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d3f, name = 'com.apple.tsm.portname' 17:43:41 INFO - PROCESS | 1632 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:43:41 INFO - PROCESS | 1632 | 2017-01-27 17:43:41.513 plugin-container[1634:7560] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9113, name = 'com.apple.CFPasteboardClient' 17:43:41 INFO - PROCESS | 1632 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:43:41 INFO - PROCESS | 1632 | 2017-01-27 17:43:41.513 plugin-container[1634:7560] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:43:41 INFO - PROCESS | 1632 | __metrics Screen width/height:1600/1200 17:43:41 INFO - PROCESS | 1632 | colorDepth:24 17:43:41 INFO - PROCESS | 1632 | Browser inner width/height: 1024/689 17:43:41 INFO - PROCESS | 1632 | __metrics 17:43:41 ERROR - PROCESS | 1632 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3279: TypeError: this.tabs is undefined 17:43:42 INFO - TEST-INFO | 1632: exit 0 17:43:42 INFO - Browser initialized. 17:43:42 INFO - Running cycle 1/1 for dromaeo_css test... 17:43:42 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/tmpP_5kIk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:43:44 INFO - PROCESS | 1635 | 2017-01-27 17:43:44.877 plugin-container[1636:7687] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e3f, name = 'com.apple.tsm.portname' 17:43:44 INFO - PROCESS | 1635 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:43:44 INFO - PROCESS | 1635 | 2017-01-27 17:43:44.878 plugin-container[1636:7687] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x920f, name = 'com.apple.CFPasteboardClient' 17:43:44 INFO - PROCESS | 1635 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:43:44 INFO - PROCESS | 1635 | 2017-01-27 17:43:44.878 plugin-container[1636:7687] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:43:54 INFO - PROCESS | 1635 | RSS: Main: 233234432 17:43:54 INFO - PROCESS | 1635 | 17:46:56 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49248/tests/dromaeo/cssquery-ext.html) 17:46:58 INFO - PROCESS | 1635 | RSS: Main: 255250432 17:46:58 INFO - PROCESS | 1635 | 17:48:42 INFO - PROCESS | 1635 | ************************* 17:48:42 INFO - PROCESS | 1635 | A coding exception was thrown and uncaught in a Task. 17:48:42 INFO - PROCESS | 1635 | 17:48:42 ERROR - PROCESS | 1635 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:48:42 INFO - PROCESS | 1635 | Full stack: 17:48:42 INFO - PROCESS | 1635 | ************************* 17:50:00 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-ext.html (next: http://localhost:49248/tests/dromaeo/cssquery-jquery.html) 17:50:01 INFO - PROCESS | 1635 | RSS: Main: 263667712 17:50:01 INFO - PROCESS | 1635 | 17:53:03 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49248/tests/dromaeo/cssquery-mootools.html) 17:53:03 INFO - PROCESS | 1635 | RSS: Main: 274550784 17:53:03 INFO - PROCESS | 1635 | 17:56:05 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49248/tests/dromaeo/cssquery-prototype.html) 17:56:06 INFO - PROCESS | 1635 | RSS: Main: 270716928 17:56:06 INFO - PROCESS | 1635 | 17:59:09 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49248/tests/dromaeo/cssquery-yui.html) 17:59:10 INFO - PROCESS | 1635 | RSS: Main: 275722240 17:59:10 INFO - PROCESS | 1635 | 18:02:12 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-yui.html (next: http://localhost:49248/tests/dromaeo/cssquery-dojo.html) 18:02:12 INFO - PROCESS | 1635 | RSS: Main: 277544960 18:02:12 INFO - PROCESS | 1635 | 18:02:12 INFO - PROCESS | 1635 | __start_tp_report 18:02:12 INFO - PROCESS | 1635 | _x_x_mozilla_page_load 18:02:12 INFO - PROCESS | 1635 | _x_x_mozilla_page_load_details 18:02:12 INFO - PROCESS | 1635 | |i|pagename|runs| 18:02:12 INFO - PROCESS | 1635 | |0;dojo.html;3024.1985873743456;3281.278118813863;3315.0386387947497;3325.517799919013;3356.8321583920806;4616.146012987596;5419.376771671259;5489.2040654105185;5517.310336207974;5530.5852061095375;5546.584006199531;5593.216949627055;5610.158476228567;5680.460356266148;5735.512481439083;4797.208460604013;5112.309838171855;5126.231065340201;5239.659422137568;5242.292290540785;5130.948690513103;5211.921821172686;5217.217417387385;5235.764390602413;5284.365876094855;5049.394072711261;5086.949130508721;5195.870103247411;5197.986392653434;5221.2429197766305;5075.670081444694;5124.769385377667;5165.586753059783;5188.169892817131;5236.371635403738;5054.014467178901;5132.050570644443;5134.512221338967;5162.12243918531;5166.560842328407;4339.631131353807;5486.862828429321;5565.2486914266465;5627.071533197059;5638.464345887134;6088.025915853442;6112.138751317694;6119.502553941423;6121.81881567809;6220.875582488325;6270.843228919268;6275.090111933744;6276.623402595813;6282.277538083134;6289.591176573508;5804.245448091721;5806.129080637938;5806.187133801272;5810.302763668345;5842.941570584282;6177.073438984098;6178.135061091451;6244.875102497925;6249.468795152463;6262.1546091278005;6089.512838972872;6105.9694701526205;6113.144159817629;6114.724837382329;6115.605440958429;6198.064035740878;6207.255129384503;6247.125402443661;6248.31268560458;6251.28110267316;5960.314563825215;5986.5809393342915;6101.237345331833;6114.996965385453;6137.601055931439;6213.751449942042;6217.813465596039;6224.253089629274;6231.501479881598;6245.781397651061;4973.35346404965;4975.253711943237;4989.0770207511005;4992.101421744048;5031.169856973632;4355.5208927018;4395.428594282723;4404.383386325917;4463.66522510813;4466.865994020184;5659.349174844946;5674.744636491368;5695.117256825199;5713.342965559014;5766.596338256281;6257.906131408033;6260.530460215502;6267.4986001119805;6274.090256912722;6274.341194174637;5530.806421775219;5539.058360078796;5593.105103183471;5694.544436445074;5704.429557044263;4926.3842019747535;5115.258287548285;5335.226392173113;5363.865903352447;5409.972950135224;6305.243370795625;6309.526785491014;6310.936890631035;6319.431251187415;6326.2724786649205;5457.781688732406;6061.696915154136;6203.8138855834395;6232.844178895564;6268.529860260407;6184.226971628546;6228.719707613078;6243.656598887105;6259.499240060875;6306.810795676137;6154.629957993456;6161.661108639068;6181.5363847710705;6183.938160618336;6211.006239001738;6109.816705498843;6276.748930042747;6286.811395658137;6294.622322660655;6302.180716506825;5851.093080572518;5906.497947674496;5993.160957466045;6006.249218847644;6034.577579569388;5989.790357337472;6042.939570604413;6064.241969753781;6075.513958883367;6119.2350956130485;5190.922136167885;5693.943060569507;5749.7125143741805;5886.911696324473;5887.499562537061;5950.9702451487465;5965.313988891333;6008.789692360921;6058.969705151622;6134.969325153525;5860.472557469848;5872.207252021093;5904.527637789052;5952.226210592596;5960.493358064613 18:02:12 INFO - PROCESS | 1635 | |1;ext.html;447.94176757021563;498.3795175007114;509.635610538465;519.3819354967587;523.9947600523993;29326.601009848535;41400.79299603505;41461.58538414615;41494.17011659765;41828.37257441137;41826.28129171602;42320.365194522106;42444.575554244446;42447.36328955068;42570.93572660685;9225.677101301455;9534.80930381392;9538.713838584854;10918.235723499318;11328.716782080473;11123.221374503788;11204.775904481947;11207.943960280187;11208.495617697223;11224.382658953755;9484;11157.776844463106;11173;11248.100151987821;11268.32390056595;11073.280236784663;11117.27737697047;11121.332720036824;11135.554577816918;11170.106391488662;10956.726081847937;10970.232083754141;11017.394043327613;11029.503672334764;11043.006129448308;36631.81684091589;36880.81559592212;37024.7041353554;37025.629743702484;37136.25727485435;3854.4796452478836;3867.5552311483975;3904.824282907276;3919.627635374635;3927.293087244295;28039.439211215864;28572.857135714396;28577.71422285792;28736.856315718287;28804.855975719987;2664.107523979469;3078.1688943985223;3163.383140287645;3195.8402079896146;3305.8677652893857;371740;439380;459184;459987;461464;55689.44310556923;55848.72075639596;55938.44061559414;56042.879142416925;56104.719476403174;57875.421245787;57933;58324;58482;59121.70439147777;15204;15479.767803482957;15572.221388930508;15575.909686322075;15622.140782257085;8596.441231319945;10675.359478431319;11831;12158;12213.145079844326;17634.5591360217;17676.823231767776;17794.02132882678;17830.286788528312;17976.37082702099;7338.77983660491;7807.414443916729;7959.880601790977;8026.719064832703;8056.194380561897;785.8742601183898;845.3490812074791;847.8855354527183;850.9064002959669;853.5532272797549;24923.87538062298;29865.325588138185;29909;30536.84731576328;30854.691453085183;982.6806287956442;1030.3817709374466;1058.571278632155;1070.8607880975578;1086.8478413022183;14152.150870947777;14265.928670356789;15443.610075093295;15456.690866182613;15861.048337099812;591371;604644;605683;607960;608056;60406;60652.69673651692;61386.38613613807;61393.386066138766;61671.38328616746;1201.2492192379764;1335.619348485677;1387.2647496826698;1401.5655146904492;1404.557564367221;27508.899644014014;29505.557416639196;30147.547786783656;30475;30625.846870765505;50245.74877125591;50659.49340506548;51021;51104.48895510997;51133;518532;521287;526183;526865;527626;24224.273271801874;24816;24868.37829054288;26107.955681772517;26587;41936.58063419327;42292.94267643333;42433.5756642442;43381.04785284733;43533.564664352954;30429.782808687403;32591;35267.29465410729;35566.46650300196;36602.633973659926;27033.45933081367;33602.32795344129;34170.82914585411;35863.64136358707;36599.45100823436;25959.740402595733;34704.826475867456;34759.652403475644;35217.647823522464;35310.76412325556;30064.947726829458;31028.0691579253;31068.53397199089;31090.067297981095;31252;22596.096156154228;23413.04607542506;23429.53140937206;23650.172243971378;23832 18:02:12 INFO - PROCESS | 1635 | |2;jquery.html;362.7424528584705;387.5231220502609;390.5567181249281;396.8253968253968;418.2137581347067;15678.608034799136;15932.84067159328;21037.263695770653;21563.353099407024;21809.018594163263;20402.489937751525;20890.268840590583;20963.161473541077;21464.356069317906;21678.807665578388;4682.157211701892;5171.922421163686;5353.705546194958;5611.719414029282;5615.5507559395355;5321.122014867542;5484.149956756689;5554.1391084381985;5612.635178713391;5615.522680572156;5489.451054894498;5514.834554963358;5545.390007099216;5548.6393384430085;5576.107822748361;5335.946640533583;5490;5509.724513774296;5535.58483113768;5546.140348246028;5413.783448662049;5421.891562168735;5423.620346575742;5424.159255315432;5429.321334833146;13461.778806496915;13700.725985480334;13706.246156461391;13891.930540347335;13905.443782248698;2247.134853081559;2715.701272859984;2722.91831245061;2725.509408306504;2728.9181324560295;10188.184945204366;10496.94751526245;10589.93496268228;11466.713332166679;14906.552803415914;1859.7024476083761;1906.4566598519355;1920.3215792406256;1923.1057558235489;1926.7398901148306;136547.31726341305;141785;143624;145060;145672.27163864218;11672.299662020307;12140.45367958444;12153.453094610764;12171.356866822865;12171.634850954486;13973.301334933212;15307;15890.92054539743;15895.841041589436;15916.965397249141;7250.854982900312;7327.780166595011;7723.575203363756;8150.673973041012;8618.181272779077;8299.626516806758;8313.625886835107;8317.209865062809;8440;8454.196851299117;4311.835804332813;4785.928211076836;4806.831760888352;4963.975180124148;4966.975165124151;2043.3563427520282;2082.4793801549613;2093.8534302598673;2097.8531502794963;2101.3942711038203;1009.4498498318434;1016.3139880580578;1022.3661329975463;1023.1661196125134;1025.8307379282485;21600.13599456004;21887.78112218889;21968.231111911326;22036;22070.78610676428;954.4034978138664;1045.3048722599538;1064.9467526623637;1068.7602381237882;1069.6470164845582;10777.622783202707;11355.034822040054;11376.658700239006;11406.657800266004;11431.942840285745;630089;698807.0119298742;704433;729390;749262;109686;114079.85920140693;143695;146922.2653886745;147028;814.9837003259902;973.7906350134755;991.4051569058507;993.2302465589082;993.2749093162032;18775.559177306863;18946.621067578297;18963.241470341032;18998.715019274445;19013.954232517346;59504.70247648734;60148.09777853248;60818.08772868499;60863;61345.69327153335;86034.56982715047;86202.56898715466;87509.12490875264;87649.56175219083;89238;7351.8529629408185;7599.412663689995;7751.961240193763;8285.461445006054;8641.790149378967;9541.950385457456;11509.597164099216;13356.332183390987;13555.728885422433;14181.503647372292;11521.251118677259;11758.41261429696;12026.218295810744;12098.697532561404;12126.029917606747;10269.794604108025;10508.369497830156;11029.558817647205;11676.416179190837;11847.703807404883;11097.556097756;11309.604163854226;11724.00345970602;11764.941175294069;12031.939840300742;8526.573671316533;8548;8701.521416322163;8781.165789250012;8955;9122.589483473392;11656.417179141179;11839.58561450345;11966.700832479257;12105.54991827325 18:02:12 INFO - PROCESS | 1635 | |3;mootools.html;1220.7497463020081;1403.6982048859493;1410.2243765928736;1414.5473448496484;1418.0286503744933;7385.778426647195;7608.201138880421;7859.489133206338;8240;8290.170982901707;7802.882956755653;7972.760817175479;8052.8389432211325;8086.67653293869;8103.91896081039;1928.594995051041;2225.4992626658996;2268.920587779428;2269.307861102363;2276.567452184088;1950.9707354389625;1994.750656167979;2023.1199428248685;2238.0488292475634;2272.5000499889998;2194.846360754748;2273.2043784675398;2274.1812947338944;2275.3515248154195;2275.681404603357;2249.4151520604596;2254.3913143451177;2263.4680850000236;2276.886155692209;2278.305116939333;1865.4963159946738;1936.6804477261235;2228.075348730275;2291.209532711212;2298.092253559851;6844.2129155147295;8159.55122468264;8192.713255036046;8212.917870821335;8269.21442462965;4949.232868905326;5072.847814565569;5092.694438333712;5093.949060509384;5106.106431374495;3285.720713739335;3387.271736576648;3410.7271418286477;3446.483027545888;3449.275652113059;1003.2174903575223;1208.4380762945273;1237.894778943791;1249.8562665293516;1710.2987775012186;8957.417767845134;9861.359011664219;10315.587376504931;10585.259031867772;10586.100181484582;3952.9802350988634;4374.737515749065;4574.199515084847;4618.399608050931;4683.391159149289;9095.272378209727;9138.54307284633;9193.95403022994;9215.493147876798;9236.815263694689;5153.6907785532985;5162.432132465426;5163.767630456563;5170.069387510209;5171.741412929338;4593.839215627437;4601.884952876205;4630.74530900797;4665.766711664403;4679.157751604744;3791.5071040764524;3807.6573108420375;3849.40334248192;3903.2583809076186;3935.2916475034194;1177.5457310221868;1217.287886586357;1258.1758947889148;1277.916935399196;1291.5027714330051;640.4076229487798;744.7877354953812;761.954282743026;768.3161985832613;821.5358322547742;5259.710715910662;5307;5359.490848369399;5443.945560544344;5499.450054994469;808.292743849132;962.2350231565922;987.2891518106951;989.1789814453986;1044.8119338519139;3587.6412358763914;3611.963880361163;3648.8540458381367;3696;3744.475773391727;8374.1625837417;9738;9754.219662426989;9756.121949024622;9759.316847820726;9595.088466595662;9687.079727425884;9703.805923881624;9716.805663886682;9735.951320243354;7264.636768161571;7643.082830060428;7678.769636910902;7734.922650773533;7737.342325902248;5392.703401312965;5486.807961721321;5492.368377636463;5565.332160140809;5577.44225577439;8774.912250877409;8799.47203167812;8890.555472226491;8904.73285801427;8914.108589141035;8867.379283450096;9050.864237036318;9058.456492610465;9128.087191280818;9201.953990230006;6228.501719862309;6370.203724534434;6848.6918088687125;7034.366906978396;7053.294670532906;7799.376049916106;7851.882221766564;7870.252326029018;7871.48835325702;7875.330596899328;6872.62200578973;6950.8609827804175;6959.826004349932;7000.334968178015;7047.330503602149;6884.827879302858;6909.481788865754;6929.618870962146;6981.406580440516;6994.720211191699;6031.396860314109;6198.318184999556;6201.3178550358525;6262.780802671885;6294.779682711083;3843.442700808423;4600.688803690932;4803.471618121934;4851.636127290538;4927.408710954708;3770.9441356419147;3917.8628747993685;4428.490723566831;4559.589636932692;4933.925991110064 18:02:12 INFO - PROCESS | 1635 | |4;prototype.html;265.36842315289607;332.2955334690456;344.7431663410758;355.3124703698342;364.4969941480756;4524.68327217095;4566.725996440212;5066.746662666866;5600;5639.182318563811;5081.8221362252325;5476.2333273341765;5533;5590.077637189859;5590.496855283034;3518.3842827505214;4039.111395492987;4060.7614677523343;4198.580141985807;4208.55810139934;3518.788872667635;4003.85890021344;4010.3182458981896;4275.401443797855;4290.377895205193;4223.683223758215;4317.848875289365;4329.372241025049;4336.739795612258;4383.232934236512;3549.929001419983;3858.9035274118373;3888.105735680781;4164.75011499311;4308.504521979981;3517;3524.4713293006;3533.116720819795;3537.4163263061564;3562.1450851795644;4206.7265627734405;5329.960657671755;5351.0736134991375;5381.206249594027;5403.756830942578;3982.58618190544;4125.566815484391;4136.338185890273;4502.662300327489;4735.5958958168885;5815.767369305223;5908.9909430793305;5943.3759455257;5944.978707239516;5965.55258355625;3966.841326346943;3982.3827306767207;3983.621555952209;4004.2992476316526;4026.45642838216;5020.59835213182;5182.248573956793;5553.750081246394;6216.937830621727;6337.345786923712;3744.1388480649603;3931.859760669374;3961.623645753649;3994.980025099856;4009.498812648419;3135.7648176386406;3441.9311613767586;4075;4088.7342322748927;4097.852601271648;4587.889570797403;4769.833055843029;4793.712377257376;4802.511221521339;4816.518348165226;4746.905061898743;4892.363992681;5254.605904557174;5635;5950.940490595125;1111.6776134920945;1304.2370213425063;1329.2489743295007;1335.7977819961918;1337.1776357540043;754.7358424551363;829.3158144530786;843.7215718812777;871.3639043498282;900.3067637918766;4628.95371046292;5006.699598024057;5190.688558686491;5312.282841816383;5453.7818487260065;5099.597610657099;6024.909626355608;6029;6040.375774535244;6049.455549000611;4076.735012224196;4519.819207231674;4923.433805112386;5044.445111037783;5475.6584636763455;2737.7672897803513;2986.850657467118;3034.1201051695202;3045.1169160943077;3090.6754790747095;5370.167624018283;5651.321841379061;5759.60683641158;5990.622156903936;6020.397960204032;5317.8936421271355;5491.203775452537;6137.7851775187655;6233.353488209357;6247.250329960434;6157.599756015845;6247.219097612708;6265.154204182468;6269.435750782269;6275.560710750204;4640.466346370211;4757.001029783646;5373.5432488237375;6010.7295171716505;6011.969940150271;5231.142944254735;5566.693831839288;5588.273524441796;5983.34183239852;6001.309849367379;5425.3144693377035;5459.481349271813;5965.6718880461995;6235.657038862906;6290.811275661737;3760.7367484275837;3961.6830653548222;3975.562688104364;3989.261986532501;4015.77913214776;5560.7219639018695;5613.803516876889;6049.697515124139;6073.937061014393;6081.331053584191;4768.76156192196;5640.435956404327;5834.358220595816;5874.472637114466;5887.264091988502;4674.883127921829;4682.648801339845;5802.953449439078;5847.883042339045;5867.618604790675;5427.810026649048;5698.059820129798;5723.484886360247;5727.6849773262875;5763.855903602276;4573.474050484104;5457.345118585795;5749.223854779551;5811.82564523065;5814.389489103753;5726.312842458931;5735.541156707537;5745.339285981999;5746.9712651436475;5750.6837123958585 18:02:12 INFO - PROCESS | 1635 | |5;yui.html;706.9505134640574;711.3384552366298;739.7706710919614;786.0842118931445;836.4395854777297;14613.342399592017;15475.226238688063;15529;15549.222538873068;15640.921795391036;11812.350320732356;11999.64001079969;13238.139520931132;13535.796963045563;14377.209253491053;665.4144352969404;675.7499725101719;700.3171907390279;845.3828705045321;860.2816648098845;725.4885305859383;861.4874149880842;872.2237208884098;874.7288340614398;876.1545108969843;900.3787386703154;927.2118699105773;929.061647735785;932.0912110692055;934.7896723237285;914.076782449724;917.1424717888762;917.4357769971452;918.5499105438287;919.2508105893742;681.8534015186758;682.1575354437266;688.2944981394061;688.6109348218291;691.312144416304;14574.344154513072;14927.029743066665;14968.401263949429;15308.846911530853;15589;13608.455661773518;13914.373853176632;13916.30418479072;14011.08927919682;14027.859721402758;11539.48072336747;11567;11705.3562054087;12075.732048134994;12230.816537751853;3647.4316044101024;3726.3478891194204;3735.9452301234214;3738.102855314732;3758.567764707039;94471.58292625616;95870.52064739632;96607;96997;97123.51438242834;10766.946165269124;10872.238943274053;10986.450677466095;11337.036351910016;11370.715732106764;21921.342359728915;22153.556928861653;22285.4400191985;22515.54968900613;22580.20969266068;6876.518643694993;6892.483063770237;7462.813429664193;7545.597492075897;7549.282818132268;4104.651104656137;4113.753174809521;4121.91756164875;4127.814248358831;4134.91730165395;3432.7768695034742;3522.172289511963;3560.038789526865;3563.3585954528435;3565.8038807865296;629.3957800511469;635.6535688050024;638.6647010319526;650.4308729861372;651.260818970472;602.4036204157852;607.9604825686316;613.8219916224245;622.996885015572;626.4236902050125;7790.571518566533;8275.337972962148;8486.660533578588;8637.69768058115;9177.678781242757;601.4346514276566;610.0909644629559;627.4666533446625;638.0493065332714;641.8010416770816;3626.38351480249;4116.91766164675;4380.123975204971;4486.842960496432;4511.436070491189;98261.01738982518;101706.49146754219;102039.95920081557;103652.96347036584;104826.47586762017;83593.58203208946;83828;87682.56158719165;87994;88605.11394885968;50550.24174637383;77291;77648;78203.2179678196;78561.60719196482;6244.219472565929;8515.787105322417;8534.23191912706;8640.13598640131;8642.434891374105;44718.55281447274;52293.215601766766;52389.47610523846;54143.72928135334;54659;69271.65364173146;69749;70224;72142.27857721565;73594.89607655782;10565.9471702641;10595.629152979609;10815.297005694605;10842.728931776768;10847.67456976292;9711;10290.588376464857;11697.941510292734;11779;12149.1495595311;11284.661460156209;11388.202825802115;11406.657800266004;11436.256643318158;11537.82693259585;11314.60398886035;11339.489722962322;11472.94263528677;11517;11748.530058797553;10236.33463824849;10707.036366726721;10745;11096.389698566656;11207.943960280147;8247.546384948886;8308.381375163262;8372.539510326991;8438.451500652438;8492.57537123129;7190.555211228208;7840.3727701784865;8236.629351679068;8265.669373225004;8563.486190828571 18:02:12 INFO - PROCESS | 1635 | __end_tp_report 18:02:12 INFO - PROCESS | 1635 | __start_cc_report 18:02:12 INFO - PROCESS | 1635 | _x_x_mozilla_cycle_collect,387 18:02:12 INFO - PROCESS | 1635 | __end_cc_report 18:02:12 INFO - PROCESS | 1635 | __startTimestamp1485568932911__endTimestamp 18:02:12 INFO - PROCESS | 1635 | 18:02:12 INFO - PROCESS | 1635 | ------- Summary: start ------- 18:02:12 INFO - PROCESS | 1635 | Number of tests: 6 18:02:12 INFO - PROCESS | 1635 | 18:02:12 INFO - PROCESS | 1635 | [#0] dojo.html Cycles:165 Average:5674.53 Median:5886.91 stddev:663.06 (11.3%) stddev-sans-first:631.65 18:02:12 INFO - PROCESS | 1635 | Values: 3024.2 3281.3 3315.0 3325.5 3356.8 4616.1 5419.4 5489.2 5517.3 5530.6 5546.6 5593.2 5610.2 5680.5 5735.5 4797.2 5112.3 5126.2 5239.7 5242.3 5130.9 5211.9 5217.2 5235.8 5284.4 5049.4 5086.9 5195.9 5198.0 5221.2 5075.7 5124.8 5165.6 5188.2 5236.4 5054.0 5132.1 5134.5 5162.1 5166.6 4339.6 5486.9 5565.2 5627.1 5638.5 6088.0 6112.1 6119.5 6121.8 6220.9 6270.8 6275.1 6276.6 6282.3 6289.6 5804.2 5806.1 5806.2 5810.3 5842.9 6177.1 6178.1 6244.9 6249.5 6262.2 6089.5 6106.0 6113.1 6114.7 6115.6 6198.1 6207.3 6247.1 6248.3 6251.3 5960.3 5986.6 6101.2 6115.0 6137.6 6213.8 6217.8 6224.3 6231.5 6245.8 4973.4 4975.3 4989.1 4992.1 5031.2 4355.5 4395.4 4404.4 4463.7 4466.9 5659.3 5674.7 5695.1 5713.3 5766.6 6257.9 6260.5 6267.5 6274.1 6274.3 5530.8 5539.1 5593.1 5694.5 5704.4 4926.4 5115.3 5335.2 5363.9 5410.0 6305.2 6309.5 6310.9 6319.4 6326.3 5457.8 6061.7 6203.8 6232.8 6268.5 6184.2 6228.7 6243.7 6259.5 6306.8 6154.6 6161.7 6181.5 6183.9 6211.0 6109.8 6276.7 6286.8 6294.6 6302.2 5851.1 5906.5 5993.2 6006.2 6034.6 5989.8 6042.9 6064.2 6075.5 6119.2 5190.9 5693.9 5749.7 5886.9 5887.5 5951.0 5965.3 6008.8 6059.0 6135.0 5860.5 5872.2 5904.5 5952.2 5960.5 18:02:12 INFO - PROCESS | 1635 | 18:02:12 INFO - PROCESS | 1635 | [#1] ext.html Cycles:180 Average:65368.88 Median:34437.83 stddev:140586.72 (408.2%) stddev-sans-first:140896.61 18:02:12 INFO - PROCESS | 1635 | Values: 447.9 498.4 509.6 519.4 524.0 29326.6 41400.8 41461.6 41494.2 41828.4 41826.3 42320.4 42444.6 42447.4 42570.9 9225.7 9534.8 9538.7 10918.2 11328.7 11123.2 11204.8 11207.9 11208.5 11224.4 9484.0 11157.8 11173.0 11248.1 11268.3 11073.3 11117.3 11121.3 11135.6 11170.1 10956.7 10970.2 11017.4 11029.5 11043.0 36631.8 36880.8 37024.7 37025.6 37136.3 3854.5 3867.6 3904.8 3919.6 3927.3 28039.4 28572.9 28577.7 28736.9 28804.9 2664.1 3078.2 3163.4 3195.8 3305.9 371740.0 439380.0 459184.0 459987.0 461464.0 55689.4 55848.7 55938.4 56042.9 56104.7 57875.4 57933.0 58324.0 58482.0 59121.7 15204.0 15479.8 15572.2 15575.9 15622.1 8596.4 10675.4 11831.0 12158.0 12213.1 17634.6 17676.8 17794.0 17830.3 17976.4 7338.8 7807.4 7959.9 8026.7 8056.2 785.9 845.3 847.9 850.9 853.6 24923.9 29865.3 29909.0 30536.8 30854.7 982.7 1030.4 1058.6 1070.9 1086.8 14152.2 14265.9 15443.6 15456.7 15861.0 591371.0 604644.0 605683.0 607960.0 608056.0 60406.0 60652.7 61386.4 61393.4 61671.4 1201.2 1335.6 1387.3 1401.6 1404.6 27508.9 29505.6 30147.5 30475.0 30625.8 50245.7 50659.5 51021.0 51104.5 51133.0 518532.0 521287.0 526183.0 526865.0 527626.0 24224.3 24816.0 24868.4 26108.0 26587.0 41936.6 42292.9 42433.6 43381.0 43533.6 30429.8 32591.0 35267.3 35566.5 36602.6 27033.5 33602.3 34170.8 35863.6 36599.5 25959.7 34704.8 34759.7 35217.6 35310.8 30064.9 31028.1 31068.5 31090.1 31252.0 22596.1 23413.0 23429.5 23650.2 23832.0 18:02:12 INFO - PROCESS | 1635 | 18:02:12 INFO - PROCESS | 1635 | [#2] jquery.html Cycles:180 Average:38982.65 Median:21639.47 stddev:117388.64 (542.5%) stddev-sans-first:117682.13 18:02:12 INFO - PROCESS | 1635 | Values: 362.7 387.5 390.6 396.8 418.2 15678.6 15932.8 21037.3 21563.4 21809.0 20402.5 20890.3 20963.2 21464.4 21678.8 4682.2 5171.9 5353.7 5611.7 5615.6 5321.1 5484.1 5554.1 5612.6 5615.5 5489.5 5514.8 5545.4 5548.6 5576.1 5335.9 5490.0 5509.7 5535.6 5546.1 5413.8 5421.9 5423.6 5424.2 5429.3 13461.8 13700.7 13706.2 13891.9 13905.4 2247.1 2715.7 2722.9 2725.5 2728.9 10188.2 10496.9 10589.9 11466.7 14906.6 1859.7 1906.5 1920.3 1923.1 1926.7 136547.3 141785.0 143624.0 145060.0 145672.3 11672.3 12140.5 12153.5 12171.4 12171.6 13973.3 15307.0 15890.9 15895.8 15917.0 7250.9 7327.8 7723.6 8150.7 8618.2 8299.6 8313.6 8317.2 8440.0 8454.2 4311.8 4785.9 4806.8 4964.0 4967.0 2043.4 2082.5 2093.9 2097.9 2101.4 1009.4 1016.3 1022.4 1023.2 1025.8 21600.1 21887.8 21968.2 22036.0 22070.8 954.4 1045.3 1064.9 1068.8 1069.6 10777.6 11355.0 11376.7 11406.7 11431.9 630089.0 698807.0 704433.0 729390.0 749262.0 109686.0 114079.9 143695.0 146922.3 147028.0 815.0 973.8 991.4 993.2 993.3 18775.6 18946.6 18963.2 18998.7 19014.0 59504.7 60148.1 60818.1 60863.0 61345.7 86034.6 86202.6 87509.1 87649.6 89238.0 7351.9 7599.4 7752.0 8285.5 8641.8 9542.0 11509.6 13356.3 13555.7 14181.5 11521.3 11758.4 12026.2 12098.7 12126.0 10269.8 10508.4 11029.6 11676.4 11847.7 11097.6 11309.6 11724.0 11764.9 12031.9 8526.6 8548.0 8701.5 8781.2 8955.0 9122.6 11656.4 11839.6 11966.7 12105.5 18:02:12 INFO - PROCESS | 1635 | 18:02:12 INFO - PROCESS | 1635 | [#3] mootools.html Cycles:180 Average:5249.23 Median:5333.25 stddev:2851.92 (53.5%) stddev-sans-first:2843.85 18:02:12 INFO - PROCESS | 1635 | Values: 1220.7 1403.7 1410.2 1414.5 1418.0 7385.8 7608.2 7859.5 8240.0 8290.2 7802.9 7972.8 8052.8 8086.7 8103.9 1928.6 2225.5 2268.9 2269.3 2276.6 1951.0 1994.8 2023.1 2238.0 2272.5 2194.8 2273.2 2274.2 2275.4 2275.7 2249.4 2254.4 2263.5 2276.9 2278.3 1865.5 1936.7 2228.1 2291.2 2298.1 6844.2 8159.6 8192.7 8212.9 8269.2 4949.2 5072.8 5092.7 5093.9 5106.1 3285.7 3387.3 3410.7 3446.5 3449.3 1003.2 1208.4 1237.9 1249.9 1710.3 8957.4 9861.4 10315.6 10585.3 10586.1 3953.0 4374.7 4574.2 4618.4 4683.4 9095.3 9138.5 9194.0 9215.5 9236.8 5153.7 5162.4 5163.8 5170.1 5171.7 4593.8 4601.9 4630.7 4665.8 4679.2 3791.5 3807.7 3849.4 3903.3 3935.3 1177.5 1217.3 1258.2 1277.9 1291.5 640.4 744.8 762.0 768.3 821.5 5259.7 5307.0 5359.5 5443.9 5499.5 808.3 962.2 987.3 989.2 1044.8 3587.6 3612.0 3648.9 3696.0 3744.5 8374.2 9738.0 9754.2 9756.1 9759.3 9595.1 9687.1 9703.8 9716.8 9736.0 7264.6 7643.1 7678.8 7734.9 7737.3 5392.7 5486.8 5492.4 5565.3 5577.4 8774.9 8799.5 8890.6 8904.7 8914.1 8867.4 9050.9 9058.5 9128.1 9202.0 6228.5 6370.2 6848.7 7034.4 7053.3 7799.4 7851.9 7870.3 7871.5 7875.3 6872.6 6950.9 6959.8 7000.3 7047.3 6884.8 6909.5 6929.6 6981.4 6994.7 6031.4 6198.3 6201.3 6262.8 6294.8 3843.4 4600.7 4803.5 4851.6 4927.4 3770.9 3917.9 4428.5 4559.6 4933.9 18:02:12 INFO - PROCESS | 1635 | 18:02:12 INFO - PROCESS | 1635 | [#4] prototype.html Cycles:180 Average:4633.39 Median:5140.92 stddev:1455.02 (28.3%) stddev-sans-first:1421.69 18:02:12 INFO - PROCESS | 1635 | Values: 265.4 332.3 344.7 355.3 364.5 4524.7 4566.7 5066.7 5600.0 5639.2 5081.8 5476.2 5533.0 5590.1 5590.5 3518.4 4039.1 4060.8 4198.6 4208.6 3518.8 4003.9 4010.3 4275.4 4290.4 4223.7 4317.8 4329.4 4336.7 4383.2 3549.9 3858.9 3888.1 4164.8 4308.5 3517.0 3524.5 3533.1 3537.4 3562.1 4206.7 5330.0 5351.1 5381.2 5403.8 3982.6 4125.6 4136.3 4502.7 4735.6 5815.8 5909.0 5943.4 5945.0 5965.6 3966.8 3982.4 3983.6 4004.3 4026.5 5020.6 5182.2 5553.8 6216.9 6337.3 3744.1 3931.9 3961.6 3995.0 4009.5 3135.8 3441.9 4075.0 4088.7 4097.9 4587.9 4769.8 4793.7 4802.5 4816.5 4746.9 4892.4 5254.6 5635.0 5950.9 1111.7 1304.2 1329.2 1335.8 1337.2 754.7 829.3 843.7 871.4 900.3 4629.0 5006.7 5190.7 5312.3 5453.8 5099.6 6024.9 6029.0 6040.4 6049.5 4076.7 4519.8 4923.4 5044.4 5475.7 2737.8 2986.9 3034.1 3045.1 3090.7 5370.2 5651.3 5759.6 5990.6 6020.4 5317.9 5491.2 6137.8 6233.4 6247.3 6157.6 6247.2 6265.2 6269.4 6275.6 4640.5 4757.0 5373.5 6010.7 6012.0 5231.1 5566.7 5588.3 5983.3 6001.3 5425.3 5459.5 5965.7 6235.7 6290.8 3760.7 3961.7 3975.6 3989.3 4015.8 5560.7 5613.8 6049.7 6073.9 6081.3 4768.8 5640.4 5834.4 5874.5 5887.3 4674.9 4682.6 5803.0 5847.9 5867.6 5427.8 5698.1 5723.5 5727.7 5763.9 4573.5 5457.3 5749.2 5811.8 5814.4 5726.3 5735.5 5745.3 5747.0 5750.7 18:02:12 INFO - PROCESS | 1635 | 18:02:12 INFO - PROCESS | 1635 | [#5] yui.html Cycles:180 Average:19455.22 Median:605.18 stddev:28563.89 (4719.9%) stddev-sans-first:28609.33 18:02:12 INFO - PROCESS | 1635 | Values: 707.0 711.3 739.8 786.1 836.4 14613.3 15475.2 15529.0 15549.2 15640.9 11812.4 11999.6 13238.1 13535.8 14377.2 665.4 675.7 700.3 845.4 860.3 725.5 861.5 872.2 874.7 876.2 900.4 927.2 929.1 932.1 934.8 914.1 917.1 917.4 918.5 919.3 681.9 682.2 688.3 688.6 691.3 14574.3 14927.0 14968.4 15308.8 15589.0 13608.5 13914.4 13916.3 14011.1 14027.9 11539.5 11567.0 11705.4 12075.7 12230.8 3647.4 3726.3 3735.9 3738.1 3758.6 94471.6 95870.5 96607.0 96997.0 97123.5 10766.9 10872.2 10986.5 11337.0 11370.7 21921.3 22153.6 22285.4 22515.5 22580.2 6876.5 6892.5 7462.8 7545.6 7549.3 4104.7 4113.8 4121.9 4127.8 4134.9 3432.8 3522.2 3560.0 3563.4 3565.8 629.4 635.7 638.7 650.4 651.3 602.4 608.0 613.8 623.0 626.4 7790.6 8275.3 8486.7 8637.7 9177.7 601.4 610.1 627.5 638.0 641.8 3626.4 4116.9 4380.1 4486.8 4511.4 98261.0 101706.5 102040.0 103653.0 104826.5 83593.6 83828.0 87682.6 87994.0 88605.1 50550.2 77291.0 77648.0 78203.2 78561.6 6244.2 8515.8 8534.2 8640.1 8642.4 44718.6 52293.2 52389.5 54143.7 54659.0 69271.7 69749.0 70224.0 72142.3 73594.9 10565.9 10595.6 10815.3 10842.7 10847.7 9711.0 10290.6 11697.9 11779.0 12149.1 11284.7 11388.2 11406.7 11436.3 11537.8 11314.6 11339.5 11472.9 11517.0 11748.5 10236.3 10707.0 10745.0 11096.4 11207.9 8247.5 8308.4 8372.5 8438.5 8492.6 7190.6 7840.4 8236.6 8265.7 8563.5 18:02:12 INFO - PROCESS | 1635 | -------- Summary: end -------- 18:02:12 INFO - PROCESS | 1635 | 18:02:13 INFO - TEST-INFO | 1635: exit 0 18:02:13 INFO - TEST-OK | dromaeo_css | took 1115035ms 18:02:13 INFO - TEST-START | kraken 18:02:13 INFO - operating with platform_type : mac_ 18:02:13 INFO - Initialising browser for kraken test... 18:02:13 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/tmpcRNagk/profile http://localhost:49248/getInfo.html) 18:02:16 INFO - PROCESS | 1646 | 2017-01-27 18:02:16.528 plugin-container[1647:9833] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x893f, name = 'com.apple.tsm.portname' 18:02:16 INFO - PROCESS | 1646 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:02:16 INFO - PROCESS | 1646 | 2017-01-27 18:02:16.531 plugin-container[1647:9833] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c0b, name = 'com.apple.CFPasteboardClient' 18:02:16 INFO - PROCESS | 1646 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:02:16 INFO - PROCESS | 1646 | 2017-01-27 18:02:16.531 plugin-container[1647:9833] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 18:02:16 INFO - PROCESS | 1646 | __metrics Screen width/height:1600/1200 18:02:16 INFO - PROCESS | 1646 | colorDepth:24 18:02:16 INFO - PROCESS | 1646 | Browser inner width/height: 1024/689 18:02:16 INFO - PROCESS | 1646 | __metrics 18:02:16 ERROR - PROCESS | 1646 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3279: TypeError: this.tabs is undefined 18:02:17 INFO - TEST-INFO | 1646: exit 0 18:02:17 INFO - Browser initialized. 18:02:17 INFO - Running cycle 1/1 for kraken test... 18:02:17 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/tmpcRNagk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:02:19 INFO - PROCESS | 1648 | 2017-01-27 18:02:19.851 plugin-container[1649:9946] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4447, name = 'com.apple.tsm.portname' 18:02:19 INFO - PROCESS | 1648 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:02:19 INFO - PROCESS | 1648 | 2017-01-27 18:02:19.851 plugin-container[1649:9946] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f03, name = 'com.apple.CFPasteboardClient' 18:02:19 INFO - PROCESS | 1648 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:02:19 INFO - PROCESS | 1648 | 2017-01-27 18:02:19.851 plugin-container[1649:9946] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 18:02:29 INFO - PROCESS | 1648 | RSS: Main: 233631744 18:02:29 INFO - PROCESS | 1648 | 18:02:32 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-beat-detection) 18:02:33 INFO - PROCESS | 1648 | RSS: Main: 247099392 18:02:33 INFO - PROCESS | 1648 | 18:02:36 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-dft) 18:02:36 INFO - PROCESS | 1648 | RSS: Main: 255995904 18:02:36 INFO - PROCESS | 1648 | 18:02:40 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-fft) 18:02:40 INFO - PROCESS | 1648 | RSS: Main: 258080768 18:02:40 INFO - PROCESS | 1648 | 18:02:42 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-oscillator) 18:02:43 INFO - PROCESS | 1648 | RSS: Main: 260190208 18:02:43 INFO - PROCESS | 1648 | 18:02:45 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:02:45 INFO - PROCESS | 1648 | RSS: Main: 260571136 18:02:45 INFO - PROCESS | 1648 | 18:02:48 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-darkroom) 18:02:49 INFO - PROCESS | 1648 | RSS: Main: 265928704 18:02:49 INFO - PROCESS | 1648 | 18:02:52 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-desaturate) 18:02:53 INFO - PROCESS | 1648 | RSS: Main: 265306112 18:02:53 INFO - PROCESS | 1648 | 18:02:56 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49248/tests/kraken/driver.html?testName=json-parse-financial) 18:02:56 INFO - PROCESS | 1648 | RSS: Main: 265216000 18:02:56 INFO - PROCESS | 1648 | 18:02:58 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49248/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:02:59 INFO - PROCESS | 1648 | RSS: Main: 264683520 18:02:59 INFO - PROCESS | 1648 | 18:03:01 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:03:01 INFO - PROCESS | 1648 | RSS: Main: 264663040 18:03:01 INFO - PROCESS | 1648 | 18:03:04 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:03:04 INFO - PROCESS | 1648 | RSS: Main: 264794112 18:03:04 INFO - PROCESS | 1648 | 18:03:07 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:03:08 INFO - PROCESS | 1648 | RSS: Main: 265084928 18:03:08 INFO - PROCESS | 1648 | 18:03:11 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:03:12 INFO - PROCESS | 1648 | RSS: Main: 264871936 18:03:12 INFO - PROCESS | 1648 | 18:03:14 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49248/tests/kraken/driver.html?testName=ai-astar) 18:03:14 INFO - PROCESS | 1648 | RSS: Main: 266862592 18:03:14 INFO - PROCESS | 1648 | 18:03:14 INFO - PROCESS | 1648 | __start_tp_report 18:03:14 INFO - PROCESS | 1648 | _x_x_mozilla_page_load 18:03:14 INFO - PROCESS | 1648 | _x_x_mozilla_page_load_details 18:03:14 INFO - PROCESS | 1648 | |i|pagename|runs| 18:03:14 INFO - PROCESS | 1648 | |0;ai-astar;106;118;118;117;100;173;175;128;119;117 18:03:14 INFO - PROCESS | 1648 | |1;audio-beat-detection;148;114;112;148;111;119;125;111;132;113 18:03:14 INFO - PROCESS | 1648 | |2;audio-dft;201;199;204;219;236;278;196;204;192;194 18:03:14 INFO - PROCESS | 1648 | |3;audio-fft;80;60;59;84;61;60;60;61;99;84 18:03:14 INFO - PROCESS | 1648 | |4;audio-oscillator;87;70;83;70;70;76;107;97;70;83 18:03:14 INFO - PROCESS | 1648 | |5;imaging-gaussian-blur;93;86;89;85;101;116;89;105;137;98 18:03:14 INFO - PROCESS | 1648 | |6;imaging-darkroom;105;95;95;95;134;112;151;145;96;106 18:03:14 INFO - PROCESS | 1648 | |7;imaging-desaturate;101;141;92;111;92;92;92;98;136;90 18:03:14 INFO - PROCESS | 1648 | |8;json-parse-financial;60;61;60;85;98;92;76;61;60;61 18:03:14 INFO - PROCESS | 1648 | |9;json-stringify-tinderbox;70;71;75;80;75;70;71;92;107;106 18:03:14 INFO - PROCESS | 1648 | |10;stanford-crypto-aes;87;88;89;90;92;90;85;105;82;79 18:03:14 INFO - PROCESS | 1648 | |11;stanford-crypto-ccm;142;135;175;142;159;159;161;161;210;173 18:03:14 INFO - PROCESS | 1648 | |12;stanford-crypto-pbkdf2;193;247;200;178;174;176;182;176;177;177 18:03:14 INFO - PROCESS | 1648 | |13;stanford-crypto-sha256-iterative;67;72;81;87;70;67;68;69;71;66 18:03:14 INFO - PROCESS | 1648 | __end_tp_report 18:03:14 INFO - PROCESS | 1648 | __start_cc_report 18:03:14 INFO - PROCESS | 1648 | _x_x_mozilla_cycle_collect,931 18:03:14 INFO - PROCESS | 1648 | __end_cc_report 18:03:14 INFO - PROCESS | 1648 | __startTimestamp1485568994268__endTimestamp 18:03:14 INFO - PROCESS | 1648 | 18:03:14 INFO - PROCESS | 1648 | ------- Summary: start ------- 18:03:14 INFO - PROCESS | 1648 | Number of tests: 14 18:03:14 INFO - PROCESS | 1648 | 18:03:14 INFO - PROCESS | 1648 | [#0] ai-astar Cycles:10 Average:127.10 Median:118.50 stddev:25.86 (21.8%) stddev-sans-first:26.27 18:03:14 INFO - PROCESS | 1648 | Values: 106.0 118.0 118.0 117.0 100.0 173.0 175.0 128.0 119.0 117.0 18:03:14 INFO - PROCESS | 1648 | 18:03:14 INFO - PROCESS | 1648 | [#1] audio-beat-detection Cycles:10 Average:123.30 Median:122.00 stddev:14.68 (12.0%) stddev-sans-first:12.56 18:03:14 INFO - PROCESS | 1648 | Values: 148.0 114.0 112.0 148.0 111.0 119.0 125.0 111.0 132.0 113.0 18:03:14 INFO - PROCESS | 1648 | 18:03:14 INFO - PROCESS | 1648 | [#2] audio-dft Cycles:10 Average:212.30 Median:204.00 stddev:26.62 (13.0%) stddev-sans-first:27.92 18:03:14 INFO - PROCESS | 1648 | Values: 201.0 199.0 204.0 219.0 236.0 278.0 196.0 204.0 192.0 194.0 18:03:14 INFO - PROCESS | 1648 | 18:03:14 INFO - PROCESS | 1648 | [#3] audio-fft Cycles:10 Average:70.80 Median:70.50 stddev:14.57 (20.7%) stddev-sans-first:15.06 18:03:14 INFO - PROCESS | 1648 | Values: 80.0 60.0 59.0 84.0 61.0 60.0 60.0 61.0 99.0 84.0 18:03:14 INFO - PROCESS | 1648 | 18:03:14 INFO - PROCESS | 1648 | [#4] audio-oscillator Cycles:10 Average:81.30 Median:79.50 stddev:12.84 (16.2%) stddev-sans-first:13.45 18:03:14 INFO - PROCESS | 1648 | Values: 87.0 70.0 83.0 70.0 70.0 76.0 107.0 97.0 70.0 83.0 18:03:14 INFO - PROCESS | 1648 | 18:03:14 INFO - PROCESS | 1648 | [#5] imaging-gaussian-blur Cycles:10 Average:99.90 Median:87.50 stddev:16.22 (18.5%) stddev-sans-first:17.01 18:03:14 INFO - PROCESS | 1648 | Values: 93.0 86.0 89.0 85.0 101.0 116.0 89.0 105.0 137.0 98.0 18:03:14 INFO - PROCESS | 1648 | 18:03:14 INFO - PROCESS | 1648 | [#6] imaging-darkroom Cycles:10 Average:113.40 Median:123.00 stddev:21.81 (17.7%) stddev-sans-first:22.92 18:03:14 INFO - PROCESS | 1648 | Values: 105.0 95.0 95.0 95.0 134.0 112.0 151.0 145.0 96.0 106.0 18:03:14 INFO - PROCESS | 1648 | 18:03:14 INFO - PROCESS | 1648 | [#7] imaging-desaturate Cycles:10 Average:104.50 Median:92.00 stddev:19.02 (20.7%) stddev-sans-first:20.13 18:03:14 INFO - PROCESS | 1648 | Values: 101.0 141.0 92.0 111.0 92.0 92.0 92.0 98.0 136.0 90.0 18:03:14 INFO - PROCESS | 1648 | 18:03:14 INFO - PROCESS | 1648 | [#8] json-parse-financial Cycles:10 Average:71.40 Median:68.50 stddev:15.10 (22.0%) stddev-sans-first:15.44 18:03:14 INFO - PROCESS | 1648 | Values: 60.0 61.0 60.0 85.0 98.0 92.0 76.0 61.0 60.0 61.0 18:03:14 INFO - PROCESS | 1648 | 18:03:14 INFO - PROCESS | 1648 | [#9] json-stringify-tinderbox Cycles:10 Average:81.70 Median:73.00 stddev:14.65 (20.1%) stddev-sans-first:14.92 18:03:14 INFO - PROCESS | 1648 | Values: 70.0 71.0 75.0 80.0 75.0 70.0 71.0 92.0 107.0 106.0 18:03:14 INFO - PROCESS | 1648 | 18:03:14 INFO - PROCESS | 1648 | [#10] stanford-crypto-aes Cycles:10 Average:88.70 Median:88.50 stddev:6.96 (7.9%) stddev-sans-first:7.36 18:03:14 INFO - PROCESS | 1648 | Values: 87.0 88.0 89.0 90.0 92.0 90.0 85.0 105.0 82.0 79.0 18:03:14 INFO - PROCESS | 1648 | 18:03:14 INFO - PROCESS | 1648 | [#11] stanford-crypto-ccm Cycles:10 Average:161.70 Median:161.00 stddev:21.45 (13.3%) stddev-sans-first:21.54 18:03:14 INFO - PROCESS | 1648 | Values: 142.0 135.0 175.0 142.0 159.0 159.0 161.0 161.0 210.0 173.0 18:03:14 INFO - PROCESS | 1648 | 18:03:14 INFO - PROCESS | 1648 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:188.00 Median:180.00 stddev:22.39 (12.4%) stddev-sans-first:23.68 18:03:14 INFO - PROCESS | 1648 | Values: 193.0 247.0 200.0 178.0 174.0 176.0 182.0 176.0 177.0 177.0 18:03:14 INFO - PROCESS | 1648 | 18:03:14 INFO - PROCESS | 1648 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.80 Median:70.50 stddev:6.84 (9.7%) stddev-sans-first:7.04 18:03:14 INFO - PROCESS | 1648 | Values: 67.0 72.0 81.0 87.0 70.0 67.0 68.0 69.0 71.0 66.0 18:03:14 INFO - PROCESS | 1648 | -------- Summary: end -------- 18:03:14 INFO - PROCESS | 1648 | 18:03:15 INFO - TEST-INFO | 1648: exit 0 18:03:15 INFO - TEST-OK | kraken | took 61651ms 18:03:15 INFO - SUITE-END | took 1176s 18:03:15 INFO - Completed test suite (00:19:36) 18:03:15 INFO - javascript benchmark 18:03:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7137.910375292134, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3024.1985873743456, 3281.278118813863, 3315.0386387947497, 3325.517799919013, 3356.8321583920806, 4616.146012987596, 5419.376771671259, 5489.2040654105185, 5517.310336207974, 5530.5852061095375, 5546.584006199531, 5593.216949627055, 5610.158476228567, 5680.460356266148, 5735.512481439083, 4797.208460604013, 5112.309838171855, 5126.231065340201, 5239.659422137568, 5242.292290540785, 5130.948690513103, 5211.921821172686, 5217.217417387385, 5235.764390602413, 5284.365876094855, 5049.394072711261, 5086.949130508721, 5195.870103247411, 5197.986392653434, 5221.2429197766305, 5075.670081444694, 5124.769385377667, 5165.586753059783, 5188.169892817131, 5236.371635403738, 5054.014467178901, 5132.050570644443, 5134.512221338967, 5162.12243918531, 5166.560842328407, 4339.631131353807, 5486.862828429321, 5565.2486914266465, 5627.071533197059, 5638.464345887134, 6088.025915853442, 6112.138751317694, 6119.502553941423, 6121.81881567809, 6220.875582488325, 6270.843228919268, 6275.090111933744, 6276.623402595813, 6282.277538083134, 6289.591176573508, 5804.245448091721, 5806.129080637938, 5806.187133801272, 5810.302763668345, 5842.941570584282, 6177.073438984098, 6178.135061091451, 6244.875102497925, 6249.468795152463, 6262.1546091278005, 6089.512838972872, 6105.9694701526205, 6113.144159817629, 6114.724837382329, 6115.605440958429, 6198.064035740878, 6207.255129384503, 6247.125402443661, 6248.31268560458, 6251.28110267316, 5960.314563825215, 5986.5809393342915, 6101.237345331833, 6114.996965385453, 6137.601055931439, 6213.751449942042, 6217.813465596039, 6224.253089629274, 6231.501479881598, 6245.781397651061, 4973.35346404965, 4975.253711943237, 4989.0770207511005, 4992.101421744048, 5031.169856973632, 4355.5208927018, 4395.428594282723, 4404.383386325917, 4463.66522510813, 4466.865994020184, 5659.349174844946, 5674.744636491368, 5695.117256825199, 5713.342965559014, 5766.596338256281, 6257.906131408033, 6260.530460215502, 6267.4986001119805, 6274.090256912722, 6274.341194174637, 5530.806421775219, 5539.058360078796, 5593.105103183471, 5694.544436445074, 5704.429557044263, 4926.3842019747535, 5115.258287548285, 5335.226392173113, 5363.865903352447, 5409.972950135224, 6305.243370795625, 6309.526785491014, 6310.936890631035, 6319.431251187415, 6326.2724786649205, 5457.781688732406, 6061.696915154136, 6203.8138855834395, 6232.844178895564, 6268.529860260407, 6184.226971628546, 6228.719707613078, 6243.656598887105, 6259.499240060875, 6306.810795676137, 6154.629957993456, 6161.661108639068, 6181.5363847710705, 6183.938160618336, 6211.006239001738, 6109.816705498843, 6276.748930042747, 6286.811395658137, 6294.622322660655, 6302.180716506825, 5851.093080572518, 5906.497947674496, 5993.160957466045, 6006.249218847644, 6034.577579569388, 5989.790357337472, 6042.939570604413, 6064.241969753781, 6075.513958883367, 6119.2350956130485, 5190.922136167885, 5693.943060569507, 5749.7125143741805, 5886.911696324473, 5887.499562537061, 5950.9702451487465, 5965.313988891333, 6008.789692360921, 6058.969705151622, 6134.969325153525, 5860.472557469848, 5872.207252021093, 5904.527637789052, 5952.226210592596, 5960.493358064613], "value": 5630.854178652956, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [447.94176757021563, 498.3795175007114, 509.635610538465, 519.3819354967587, 523.9947600523993, 29326.601009848535, 41400.79299603505, 41461.58538414615, 41494.17011659765, 41828.37257441137, 41826.28129171602, 42320.365194522106, 42444.575554244446, 42447.36328955068, 42570.93572660685, 9225.677101301455, 9534.80930381392, 9538.713838584854, 10918.235723499318, 11328.716782080473, 11123.221374503788, 11204.775904481947, 11207.943960280187, 11208.495617697223, 11224.382658953755, 9484.0, 11157.776844463106, 11173.0, 11248.100151987821, 11268.32390056595, 11073.280236784663, 11117.27737697047, 11121.332720036824, 11135.554577816918, 11170.106391488662, 10956.726081847937, 10970.232083754141, 11017.394043327613, 11029.503672334764, 11043.006129448308, 36631.81684091589, 36880.81559592212, 37024.7041353554, 37025.629743702484, 37136.25727485435, 3854.4796452478836, 3867.5552311483975, 3904.824282907276, 3919.627635374635, 3927.293087244295, 28039.439211215864, 28572.857135714396, 28577.71422285792, 28736.856315718287, 28804.855975719987, 2664.107523979469, 3078.1688943985223, 3163.383140287645, 3195.8402079896146, 3305.8677652893857, 371740.0, 439380.0, 459184.0, 459987.0, 461464.0, 55689.44310556923, 55848.72075639596, 55938.44061559414, 56042.879142416925, 56104.719476403174, 57875.421245787, 57933.0, 58324.0, 58482.0, 59121.70439147777, 15204.0, 15479.767803482957, 15572.221388930508, 15575.909686322075, 15622.140782257085, 8596.441231319945, 10675.359478431319, 11831.0, 12158.0, 12213.145079844326, 17634.5591360217, 17676.823231767776, 17794.02132882678, 17830.286788528312, 17976.37082702099, 7338.77983660491, 7807.414443916729, 7959.880601790977, 8026.719064832703, 8056.194380561897, 785.8742601183898, 845.3490812074791, 847.8855354527183, 850.9064002959669, 853.5532272797549, 24923.87538062298, 29865.325588138185, 29909.0, 30536.84731576328, 30854.691453085183, 982.6806287956442, 1030.3817709374466, 1058.571278632155, 1070.8607880975578, 1086.8478413022183, 14152.150870947777, 14265.928670356789, 15443.610075093295, 15456.690866182613, 15861.048337099812, 591371.0, 604644.0, 605683.0, 607960.0, 608056.0, 60406.0, 60652.69673651692, 61386.38613613807, 61393.386066138766, 61671.38328616746, 1201.2492192379764, 1335.619348485677, 1387.2647496826698, 1401.5655146904492, 1404.557564367221, 27508.899644014014, 29505.557416639196, 30147.547786783656, 30475.0, 30625.846870765505, 50245.74877125591, 50659.49340506548, 51021.0, 51104.48895510997, 51133.0, 518532.0, 521287.0, 526183.0, 526865.0, 527626.0, 24224.273271801874, 24816.0, 24868.37829054288, 26107.955681772517, 26587.0, 41936.58063419327, 42292.94267643333, 42433.5756642442, 43381.04785284733, 43533.564664352954, 30429.782808687403, 32591.0, 35267.29465410729, 35566.46650300196, 36602.633973659926, 27033.45933081367, 33602.32795344129, 34170.82914585411, 35863.64136358707, 36599.45100823436, 25959.740402595733, 34704.826475867456, 34759.652403475644, 35217.647823522464, 35310.76412325556, 30064.947726829458, 31028.0691579253, 31068.53397199089, 31090.067297981095, 31252.0, 22596.096156154228, 23413.04607542506, 23429.53140937206, 23650.172243971378, 23832.0], "value": 19428.440552427328, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.7424528584705, 387.5231220502609, 390.5567181249281, 396.8253968253968, 418.2137581347067, 15678.608034799136, 15932.84067159328, 21037.263695770653, 21563.353099407024, 21809.018594163263, 20402.489937751525, 20890.268840590583, 20963.161473541077, 21464.356069317906, 21678.807665578388, 4682.157211701892, 5171.922421163686, 5353.705546194958, 5611.719414029282, 5615.5507559395355, 5321.122014867542, 5484.149956756689, 5554.1391084381985, 5612.635178713391, 5615.522680572156, 5489.451054894498, 5514.834554963358, 5545.390007099216, 5548.6393384430085, 5576.107822748361, 5335.946640533583, 5490.0, 5509.724513774296, 5535.58483113768, 5546.140348246028, 5413.783448662049, 5421.891562168735, 5423.620346575742, 5424.159255315432, 5429.321334833146, 13461.778806496915, 13700.725985480334, 13706.246156461391, 13891.930540347335, 13905.443782248698, 2247.134853081559, 2715.701272859984, 2722.91831245061, 2725.509408306504, 2728.9181324560295, 10188.184945204366, 10496.94751526245, 10589.93496268228, 11466.713332166679, 14906.552803415914, 1859.7024476083761, 1906.4566598519355, 1920.3215792406256, 1923.1057558235489, 1926.7398901148306, 136547.31726341305, 141785.0, 143624.0, 145060.0, 145672.27163864218, 11672.299662020307, 12140.45367958444, 12153.453094610764, 12171.356866822865, 12171.634850954486, 13973.301334933212, 15307.0, 15890.92054539743, 15895.841041589436, 15916.965397249141, 7250.854982900312, 7327.780166595011, 7723.575203363756, 8150.673973041012, 8618.181272779077, 8299.626516806758, 8313.625886835107, 8317.209865062809, 8440.0, 8454.196851299117, 4311.835804332813, 4785.928211076836, 4806.831760888352, 4963.975180124148, 4966.975165124151, 2043.3563427520282, 2082.4793801549613, 2093.8534302598673, 2097.8531502794963, 2101.3942711038203, 1009.4498498318434, 1016.3139880580578, 1022.3661329975463, 1023.1661196125134, 1025.8307379282485, 21600.13599456004, 21887.78112218889, 21968.231111911326, 22036.0, 22070.78610676428, 954.4034978138664, 1045.3048722599538, 1064.9467526623637, 1068.7602381237882, 1069.6470164845582, 10777.622783202707, 11355.034822040054, 11376.658700239006, 11406.657800266004, 11431.942840285745, 630089.0, 698807.0119298742, 704433.0, 729390.0, 749262.0, 109686.0, 114079.85920140693, 143695.0, 146922.2653886745, 147028.0, 814.9837003259902, 973.7906350134755, 991.4051569058507, 993.2302465589082, 993.2749093162032, 18775.559177306863, 18946.621067578297, 18963.241470341032, 18998.715019274445, 19013.954232517346, 59504.70247648734, 60148.09777853248, 60818.08772868499, 60863.0, 61345.69327153335, 86034.56982715047, 86202.56898715466, 87509.12490875264, 87649.56175219083, 89238.0, 7351.8529629408185, 7599.412663689995, 7751.961240193763, 8285.461445006054, 8641.790149378967, 9541.950385457456, 11509.597164099216, 13356.332183390987, 13555.728885422433, 14181.503647372292, 11521.251118677259, 11758.41261429696, 12026.218295810744, 12098.697532561404, 12126.029917606747, 10269.794604108025, 10508.369497830156, 11029.558817647205, 11676.416179190837, 11847.703807404883, 11097.556097756, 11309.604163854226, 11724.00345970602, 11764.941175294069, 12031.939840300742, 8526.573671316533, 8548.0, 8701.521416322163, 8781.165789250012, 8955.0, 9122.589483473392, 11656.417179141179, 11839.58561450345, 11966.700832479257, 12105.54991827325], "value": 9719.924443992519, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1220.7497463020081, 1403.6982048859493, 1410.2243765928736, 1414.5473448496484, 1418.0286503744933, 7385.778426647195, 7608.201138880421, 7859.489133206338, 8240.0, 8290.170982901707, 7802.882956755653, 7972.760817175479, 8052.8389432211325, 8086.67653293869, 8103.91896081039, 1928.594995051041, 2225.4992626658996, 2268.920587779428, 2269.307861102363, 2276.567452184088, 1950.9707354389625, 1994.750656167979, 2023.1199428248685, 2238.0488292475634, 2272.5000499889998, 2194.846360754748, 2273.2043784675398, 2274.1812947338944, 2275.3515248154195, 2275.681404603357, 2249.4151520604596, 2254.3913143451177, 2263.4680850000236, 2276.886155692209, 2278.305116939333, 1865.4963159946738, 1936.6804477261235, 2228.075348730275, 2291.209532711212, 2298.092253559851, 6844.2129155147295, 8159.55122468264, 8192.713255036046, 8212.917870821335, 8269.21442462965, 4949.232868905326, 5072.847814565569, 5092.694438333712, 5093.949060509384, 5106.106431374495, 3285.720713739335, 3387.271736576648, 3410.7271418286477, 3446.483027545888, 3449.275652113059, 1003.2174903575223, 1208.4380762945273, 1237.894778943791, 1249.8562665293516, 1710.2987775012186, 8957.417767845134, 9861.359011664219, 10315.587376504931, 10585.259031867772, 10586.100181484582, 3952.9802350988634, 4374.737515749065, 4574.199515084847, 4618.399608050931, 4683.391159149289, 9095.272378209727, 9138.54307284633, 9193.95403022994, 9215.493147876798, 9236.815263694689, 5153.6907785532985, 5162.432132465426, 5163.767630456563, 5170.069387510209, 5171.741412929338, 4593.839215627437, 4601.884952876205, 4630.74530900797, 4665.766711664403, 4679.157751604744, 3791.5071040764524, 3807.6573108420375, 3849.40334248192, 3903.2583809076186, 3935.2916475034194, 1177.5457310221868, 1217.287886586357, 1258.1758947889148, 1277.916935399196, 1291.5027714330051, 640.4076229487798, 744.7877354953812, 761.954282743026, 768.3161985832613, 821.5358322547742, 5259.710715910662, 5307.0, 5359.490848369399, 5443.945560544344, 5499.450054994469, 808.292743849132, 962.2350231565922, 987.2891518106951, 989.1789814453986, 1044.8119338519139, 3587.6412358763914, 3611.963880361163, 3648.8540458381367, 3696.0, 3744.475773391727, 8374.1625837417, 9738.0, 9754.219662426989, 9756.121949024622, 9759.316847820726, 9595.088466595662, 9687.079727425884, 9703.805923881624, 9716.805663886682, 9735.951320243354, 7264.636768161571, 7643.082830060428, 7678.769636910902, 7734.922650773533, 7737.342325902248, 5392.703401312965, 5486.807961721321, 5492.368377636463, 5565.332160140809, 5577.44225577439, 8774.912250877409, 8799.47203167812, 8890.555472226491, 8904.73285801427, 8914.108589141035, 8867.379283450096, 9050.864237036318, 9058.456492610465, 9128.087191280818, 9201.953990230006, 6228.501719862309, 6370.203724534434, 6848.6918088687125, 7034.366906978396, 7053.294670532906, 7799.376049916106, 7851.882221766564, 7870.252326029018, 7871.48835325702, 7875.330596899328, 6872.62200578973, 6950.8609827804175, 6959.826004349932, 7000.334968178015, 7047.330503602149, 6884.827879302858, 6909.481788865754, 6929.618870962146, 6981.406580440516, 6994.720211191699, 6031.396860314109, 6198.318184999556, 6201.3178550358525, 6262.780802671885, 6294.779682711083, 3843.442700808423, 4600.688803690932, 4803.471618121934, 4851.636127290538, 4927.408710954708, 3770.9441356419147, 3917.8628747993685, 4428.490723566831, 4559.589636932692, 4933.925991110064], "value": 4268.043296921996, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [265.36842315289607, 332.2955334690456, 344.7431663410758, 355.3124703698342, 364.4969941480756, 4524.68327217095, 4566.725996440212, 5066.746662666866, 5600.0, 5639.182318563811, 5081.8221362252325, 5476.2333273341765, 5533.0, 5590.077637189859, 5590.496855283034, 3518.3842827505214, 4039.111395492987, 4060.7614677523343, 4198.580141985807, 4208.55810139934, 3518.788872667635, 4003.85890021344, 4010.3182458981896, 4275.401443797855, 4290.377895205193, 4223.683223758215, 4317.848875289365, 4329.372241025049, 4336.739795612258, 4383.232934236512, 3549.929001419983, 3858.9035274118373, 3888.105735680781, 4164.75011499311, 4308.504521979981, 3517.0, 3524.4713293006, 3533.116720819795, 3537.4163263061564, 3562.1450851795644, 4206.7265627734405, 5329.960657671755, 5351.0736134991375, 5381.206249594027, 5403.756830942578, 3982.58618190544, 4125.566815484391, 4136.338185890273, 4502.662300327489, 4735.5958958168885, 5815.767369305223, 5908.9909430793305, 5943.3759455257, 5944.978707239516, 5965.55258355625, 3966.841326346943, 3982.3827306767207, 3983.621555952209, 4004.2992476316526, 4026.45642838216, 5020.59835213182, 5182.248573956793, 5553.750081246394, 6216.937830621727, 6337.345786923712, 3744.1388480649603, 3931.859760669374, 3961.623645753649, 3994.980025099856, 4009.498812648419, 3135.7648176386406, 3441.9311613767586, 4075.0, 4088.7342322748927, 4097.852601271648, 4587.889570797403, 4769.833055843029, 4793.712377257376, 4802.511221521339, 4816.518348165226, 4746.905061898743, 4892.363992681, 5254.605904557174, 5635.0, 5950.940490595125, 1111.6776134920945, 1304.2370213425063, 1329.2489743295007, 1335.7977819961918, 1337.1776357540043, 754.7358424551363, 829.3158144530786, 843.7215718812777, 871.3639043498282, 900.3067637918766, 4628.95371046292, 5006.699598024057, 5190.688558686491, 5312.282841816383, 5453.7818487260065, 5099.597610657099, 6024.909626355608, 6029.0, 6040.375774535244, 6049.455549000611, 4076.735012224196, 4519.819207231674, 4923.433805112386, 5044.445111037783, 5475.6584636763455, 2737.7672897803513, 2986.850657467118, 3034.1201051695202, 3045.1169160943077, 3090.6754790747095, 5370.167624018283, 5651.321841379061, 5759.60683641158, 5990.622156903936, 6020.397960204032, 5317.8936421271355, 5491.203775452537, 6137.7851775187655, 6233.353488209357, 6247.250329960434, 6157.599756015845, 6247.219097612708, 6265.154204182468, 6269.435750782269, 6275.560710750204, 4640.466346370211, 4757.001029783646, 5373.5432488237375, 6010.7295171716505, 6011.969940150271, 5231.142944254735, 5566.693831839288, 5588.273524441796, 5983.34183239852, 6001.309849367379, 5425.3144693377035, 5459.481349271813, 5965.6718880461995, 6235.657038862906, 6290.811275661737, 3760.7367484275837, 3961.6830653548222, 3975.562688104364, 3989.261986532501, 4015.77913214776, 5560.7219639018695, 5613.803516876889, 6049.697515124139, 6073.937061014393, 6081.331053584191, 4768.76156192196, 5640.435956404327, 5834.358220595816, 5874.472637114466, 5887.264091988502, 4674.883127921829, 4682.648801339845, 5802.953449439078, 5847.883042339045, 5867.618604790675, 5427.810026649048, 5698.059820129798, 5723.484886360247, 5727.6849773262875, 5763.855903602276, 4573.474050484104, 5457.345118585795, 5749.223854779551, 5811.82564523065, 5814.389489103753, 5726.312842458931, 5735.541156707537, 5745.339285981999, 5746.9712651436475, 5750.6837123958585], "value": 4171.72551010871, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [706.9505134640574, 711.3384552366298, 739.7706710919614, 786.0842118931445, 836.4395854777297, 14613.342399592017, 15475.226238688063, 15529.0, 15549.222538873068, 15640.921795391036, 11812.350320732356, 11999.64001079969, 13238.139520931132, 13535.796963045563, 14377.209253491053, 665.4144352969404, 675.7499725101719, 700.3171907390279, 845.3828705045321, 860.2816648098845, 725.4885305859383, 861.4874149880842, 872.2237208884098, 874.7288340614398, 876.1545108969843, 900.3787386703154, 927.2118699105773, 929.061647735785, 932.0912110692055, 934.7896723237285, 914.076782449724, 917.1424717888762, 917.4357769971452, 918.5499105438287, 919.2508105893742, 681.8534015186758, 682.1575354437266, 688.2944981394061, 688.6109348218291, 691.312144416304, 14574.344154513072, 14927.029743066665, 14968.401263949429, 15308.846911530853, 15589.0, 13608.455661773518, 13914.373853176632, 13916.30418479072, 14011.08927919682, 14027.859721402758, 11539.48072336747, 11567.0, 11705.3562054087, 12075.732048134994, 12230.816537751853, 3647.4316044101024, 3726.3478891194204, 3735.9452301234214, 3738.102855314732, 3758.567764707039, 94471.58292625616, 95870.52064739632, 96607.0, 96997.0, 97123.51438242834, 10766.946165269124, 10872.238943274053, 10986.450677466095, 11337.036351910016, 11370.715732106764, 21921.342359728915, 22153.556928861653, 22285.4400191985, 22515.54968900613, 22580.20969266068, 6876.518643694993, 6892.483063770237, 7462.813429664193, 7545.597492075897, 7549.282818132268, 4104.651104656137, 4113.753174809521, 4121.91756164875, 4127.814248358831, 4134.91730165395, 3432.7768695034742, 3522.172289511963, 3560.038789526865, 3563.3585954528435, 3565.8038807865296, 629.3957800511469, 635.6535688050024, 638.6647010319526, 650.4308729861372, 651.260818970472, 602.4036204157852, 607.9604825686316, 613.8219916224245, 622.996885015572, 626.4236902050125, 7790.571518566533, 8275.337972962148, 8486.660533578588, 8637.69768058115, 9177.678781242757, 601.4346514276566, 610.0909644629559, 627.4666533446625, 638.0493065332714, 641.8010416770816, 3626.38351480249, 4116.91766164675, 4380.123975204971, 4486.842960496432, 4511.436070491189, 98261.01738982518, 101706.49146754219, 102039.95920081557, 103652.96347036584, 104826.47586762017, 83593.58203208946, 83828.0, 87682.56158719165, 87994.0, 88605.11394885968, 50550.24174637383, 77291.0, 77648.0, 78203.2179678196, 78561.60719196482, 6244.219472565929, 8515.787105322417, 8534.23191912706, 8640.13598640131, 8642.434891374105, 44718.55281447274, 52293.215601766766, 52389.47610523846, 54143.72928135334, 54659.0, 69271.65364173146, 69749.0, 70224.0, 72142.27857721565, 73594.89607655782, 10565.9471702641, 10595.629152979609, 10815.297005694605, 10842.728931776768, 10847.67456976292, 9711.0, 10290.588376464857, 11697.941510292734, 11779.0, 12149.1495595311, 11284.661460156209, 11388.202825802115, 11406.657800266004, 11436.256643318158, 11537.82693259585, 11314.60398886035, 11339.489722962322, 11472.94263528677, 11517.0, 11748.530058797553, 10236.33463824849, 10707.036366726721, 10745.0, 11096.389698566656, 11207.943960280147, 8247.546384948886, 8308.381375163262, 8372.539510326991, 8438.451500652438, 8492.57537123129, 7190.555211228208, 7840.3727701784865, 8236.629351679068, 8265.669373225004, 8563.486190828571], "value": 6984.893120516494, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1595.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 118.0, 118.0, 117.0, 100.0, 173.0, 175.0, 128.0, 119.0, 117.0], "value": 127.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 114.0, 112.0, 148.0, 111.0, 119.0, 125.0, 111.0, 132.0, 113.0], "value": 123.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [201.0, 199.0, 204.0, 219.0, 236.0, 278.0, 196.0, 204.0, 192.0, 194.0], "value": 212.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 60.0, 59.0, 84.0, 61.0, 60.0, 60.0, 61.0, 99.0, 84.0], "value": 70.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 70.0, 83.0, 70.0, 70.0, 76.0, 107.0, 97.0, 70.0, 83.0], "value": 81.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 86.0, 89.0, 85.0, 101.0, 116.0, 89.0, 105.0, 137.0, 98.0], "value": 99.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 95.0, 95.0, 95.0, 134.0, 112.0, 151.0, 145.0, 96.0, 106.0], "value": 113.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 141.0, 92.0, 111.0, 92.0, 92.0, 92.0, 98.0, 136.0, 90.0], "value": 104.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 85.0, 98.0, 92.0, 76.0, 61.0, 60.0, 61.0], "value": 71.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 75.0, 80.0, 75.0, 70.0, 71.0, 92.0, 107.0, 106.0], "value": 81.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 89.0, 90.0, 92.0, 90.0, 85.0, 105.0, 82.0, 79.0], "value": 88.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 135.0, 175.0, 142.0, 159.0, 159.0, 161.0, 161.0, 210.0, 173.0], "value": 161.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [193.0, 247.0, 200.0, 178.0, 174.0, 176.0, 182.0, 176.0, 177.0, 177.0], "value": 188.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 72.0, 81.0, 87.0, 70.0, 67.0, 68.0, 69.0, 71.0, 66.0], "value": 71.8, "unit": "score"}]}]} 18:03:15 INFO - Return code: 0 18:03:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:03:15 ERROR - # TBPL SUCCESS # 18:03:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:03:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:03:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:03:15 INFO - 2017-01-27 18:03:15.582 screenresolution[1653:10354] starting screenresolution argv=screenresolution get 18:03:15 INFO - 2017-01-27 18:03:15.584 screenresolution[1653:10354] Display 0: 1600x1200x32@60 18:03:15 INFO - 2017-01-27 18:03:15.591 screenresolution[1654:10357] starting screenresolution argv=screenresolution list 18:03:15 INFO - Available Modes on Display 0 18:03:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:03:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:03:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:03:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:03:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:03:15 INFO - Intel Iris: 18:03:15 INFO - Chipset Model: Intel Iris 18:03:15 INFO - Type: GPU 18:03:15 INFO - Bus: Built-In 18:03:15 INFO - VRAM (Dynamic, Max): 1536 MB 18:03:15 INFO - Vendor: Intel (0x8086) 18:03:15 INFO - Device ID: 0x0a2e 18:03:15 INFO - Revision ID: 0x0009 18:03:15 INFO - Displays: 18:03:15 INFO - Display: 18:03:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:03:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:03:15 INFO - Display Serial Number: 1600x1200 60 18:03:15 INFO - Main Display: Yes 18:03:15 INFO - Mirror: Off 18:03:15 INFO - Online: Yes 18:03:15 INFO - Rotation: Supported 18:03:15 INFO - Return code: 0 18:03:15 INFO - Running post-action listener: _resource_record_post_action 18:03:15 INFO - [mozharness: 2017-01-28 02:03:15.823896Z] Finished run-tests step (success) 18:03:15 INFO - Running post-run listener: _resource_record_post_run 18:03:15 INFO - Total resource usage - Wall time: 1199s; CPU: 54.0%; Read bytes: 38824448; Write bytes: 558227968; Read time: 261; Write time: 1686 18:03:15 INFO - TinderboxPrint: CPU usage
54.3% 18:03:15 INFO - TinderboxPrint: I/O read bytes / time
38,824,448 / 261 18:03:15 INFO - TinderboxPrint: I/O write bytes / time
558,227,968 / 1,686 18:03:15 INFO - TinderboxPrint: CPU idle
2,191.0 (45.7%) 18:03:15 INFO - TinderboxPrint: CPU system
967.5 (20.2%) 18:03:15 INFO - TinderboxPrint: CPU user
1,639.2 (34.2%) 18:03:15 INFO - TinderboxPrint: Swap in / out
290,684,928 / 0 18:03:15 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 253153792; Write bytes: 257112064; Read time: 18121; Write time: 557 18:03:15 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 35367424; Write bytes: 299522560; Read time: 237; Write time: 1125 18:03:16 INFO - Running post-run listener: _upload_blobber_files 18:03:16 INFO - Blob upload gear active. 18:03:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:03:16 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 18:03:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:03:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:03:16 INFO - (blobuploader) - INFO - Open directory for files ... 18:03:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:03:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:03:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:03:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:03:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:03:17 INFO - (blobuploader) - INFO - Done attempting. 18:03:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:03:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:03:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:03:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:03:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:03:18 INFO - (blobuploader) - INFO - Done attempting. 18:03:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:03:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:03:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:03:19 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:03:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:03:19 INFO - (blobuploader) - INFO - Done attempting. 18:03:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:03:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:03:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:03:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:03:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:03:22 INFO - (blobuploader) - INFO - Done attempting. 18:03:22 INFO - (blobuploader) - INFO - Iteration through files over. 18:03:22 INFO - Return code: 0 18:03:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:03:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:03:22 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/638f191432f88def31738627c69bc29b9eddff87e3231f479021310ca61a4b6d31d17dd8f0e8ed0a14204ac84d14ca762a0af618d4bb63201f5762ea242dbd41", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/102de9daa50058699f5acd17173bc5f69904066294daebb737f2d663c8e6ded87c6fcdca1f9ee46bf8f05789add5f07460d8cb7fed152961f66574ec3a6c80de", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa44b4cf66d1849f1bbf8c579aa99ab39ff687c9aa0b925fc7bca33b4e39e6829519783b35d844948e4ce79010014f38e57db8dc6e15981e5f4d52d33427444f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d4e5b0c1e8a9af72069a97964111af957e4c0005cb1b0c3e93c422ee66f116121f1e4c570cb71b0c19435e611ded2900b8c9d6d6523ad9d3ac982fee0b9b19db"} 18:03:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:03:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:03:22 INFO - Contents: 18:03:22 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/638f191432f88def31738627c69bc29b9eddff87e3231f479021310ca61a4b6d31d17dd8f0e8ed0a14204ac84d14ca762a0af618d4bb63201f5762ea242dbd41", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/102de9daa50058699f5acd17173bc5f69904066294daebb737f2d663c8e6ded87c6fcdca1f9ee46bf8f05789add5f07460d8cb7fed152961f66574ec3a6c80de", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa44b4cf66d1849f1bbf8c579aa99ab39ff687c9aa0b925fc7bca33b4e39e6829519783b35d844948e4ce79010014f38e57db8dc6e15981e5f4d52d33427444f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d4e5b0c1e8a9af72069a97964111af957e4c0005cb1b0c3e93c422ee66f116121f1e4c570cb71b0c19435e611ded2900b8c9d6d6523ad9d3ac982fee0b9b19db"} 18:03:22 INFO - Running post-run listener: copy_logs_to_upload_dir 18:03:22 INFO - Copying logs to upload dir... 18:03:22 INFO - mkdir: /builds/slave/test/build/upload/logs 18:03:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.116370 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-01-27 18:03:22.216296) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-27 18:03:22.223356) ========= 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.wDeSxdjMY2/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.53h9eZHAzP/Listeners TMPDIR=/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/638f191432f88def31738627c69bc29b9eddff87e3231f479021310ca61a4b6d31d17dd8f0e8ed0a14204ac84d14ca762a0af618d4bb63201f5762ea242dbd41", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/102de9daa50058699f5acd17173bc5f69904066294daebb737f2d663c8e6ded87c6fcdca1f9ee46bf8f05789add5f07460d8cb7fed152961f66574ec3a6c80de", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa44b4cf66d1849f1bbf8c579aa99ab39ff687c9aa0b925fc7bca33b4e39e6829519783b35d844948e4ce79010014f38e57db8dc6e15981e5f4d52d33427444f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d4e5b0c1e8a9af72069a97964111af957e4c0005cb1b0c3e93c422ee66f116121f1e4c570cb71b0c19435e611ded2900b8c9d6d6523ad9d3ac982fee0b9b19db"} build_url:https://queue.taskcluster.net/v1/task/Nk_XgKDvSY2W-86vxrQemQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011318 build_url: 'https://queue.taskcluster.net/v1/task/Nk_XgKDvSY2W-86vxrQemQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/638f191432f88def31738627c69bc29b9eddff87e3231f479021310ca61a4b6d31d17dd8f0e8ed0a14204ac84d14ca762a0af618d4bb63201f5762ea242dbd41", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/102de9daa50058699f5acd17173bc5f69904066294daebb737f2d663c8e6ded87c6fcdca1f9ee46bf8f05789add5f07460d8cb7fed152961f66574ec3a6c80de", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa44b4cf66d1849f1bbf8c579aa99ab39ff687c9aa0b925fc7bca33b4e39e6829519783b35d844948e4ce79010014f38e57db8dc6e15981e5f4d52d33427444f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d4e5b0c1e8a9af72069a97964111af957e4c0005cb1b0c3e93c422ee66f116121f1e4c570cb71b0c19435e611ded2900b8c9d6d6523ad9d3ac982fee0b9b19db"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-27 18:03:22.262141) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 18:03:22.262448) ========= 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.wDeSxdjMY2/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.53h9eZHAzP/Listeners TMPDIR=/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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.004897 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 18:03:22.314586) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-27 18:03:22.314883) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-27 18:03:22.315244) ========= ========= Total master_lag: 0.52 =========