builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0244 starttime: 1484483100.41 results: success (0) buildid: 20170115030210 builduid: ccd28d71259f477eb807d96d7db7334d revision: 5ce3882eec21be3a70e4afc050959ca2f76bfa76 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-15 04:25:00.412537) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-15 04:25:00.412963) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-15 04:25:00.413290) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-15 04:25:00.439645) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-15 04:25:00.440273) ========= 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.pco38WBinJ/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.pgb5FQgZm4/Listeners TMPDIR=/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/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-15 04:25:00-- 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% 7.99M=0.001s 2017-01-15 04:25:01 (7.99 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.628346 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-15 04:25:01.094895) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-15 04:25:01.095211) ========= 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.pco38WBinJ/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.pgb5FQgZm4/Listeners TMPDIR=/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/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.019432 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-15 04:25:01.144052) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-15 04:25:01.144391) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5ce3882eec21be3a70e4afc050959ca2f76bfa76 --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 5ce3882eec21be3a70e4afc050959ca2f76bfa76 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.pco38WBinJ/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.pgb5FQgZm4/Listeners TMPDIR=/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/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-15 04:25:01,228 truncating revision to first 12 chars 2017-01-15 04:25:01,228 Setting DEBUG logging. 2017-01-15 04:25:01,228 attempt 1/10 2017-01-15 04:25:01,228 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5ce3882eec21?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-15 04:25:02,048 unpacking tar archive at: mozilla-central-5ce3882eec21/testing/mozharness/ program finished with exit code 0 elapsedTime=1.071910 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-15 04:25:02.239914) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-15 04:25:02.240196) ========= script_repo_revision: 5ce3882eec21be3a70e4afc050959ca2f76bfa76 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-15 04:25:02.240575) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-15 04:25:02.240842) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-15 04:25:02.397561) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-01-15 04:25:02.397848) ========= /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.pco38WBinJ/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.pgb5FQgZm4/Listeners TMPDIR=/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 04:25:02 INFO - MultiFileLogger online at 20170115 04:25:02 in /builds/slave/test 04:25:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:25:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:25:02 INFO - {'append_to_log': False, 04:25:02 INFO - 'base_work_dir': '/builds/slave/test', 04:25:02 INFO - 'blob_upload_branch': 'Firefox', 04:25:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:25:02 INFO - 'branch': 'Firefox', 04:25:02 INFO - 'buildbot_json_path': 'buildprops.json', 04:25:02 INFO - 'config_files': ('talos/mac_config.py',), 04:25:02 INFO - 'default_actions': ('clobber', 04:25:02 INFO - 'read-buildbot-config', 04:25:02 INFO - 'download-and-extract', 04:25:02 INFO - 'populate-webroot', 04:25:02 INFO - 'create-virtualenv', 04:25:02 INFO - 'install', 04:25:02 INFO - 'run-tests'), 04:25:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:25:02 INFO - 'download_minidump_stackwalk': True, 04:25:02 INFO - 'download_symbols': 'ondemand', 04:25:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:25:02 INFO - 'tooltool.py': '/tools/tooltool.py', 04:25:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:25:02 INFO - '/tools/misc-python/virtualenv.py')}, 04:25:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:25:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:25:02 INFO - 'installer_path': 'installer.exe', 04:25:02 INFO - 'log_level': 'info', 04:25:02 INFO - 'log_name': 'talos', 04:25:02 INFO - 'log_to_console': True, 04:25:02 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:25:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:25:02 INFO - 'opt_config_files': (), 04:25:02 INFO - 'pip_index': False, 04:25:02 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:25:02 INFO - 'cmd': ('bash', 04:25:02 INFO - '-c', 04:25:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:25:02 INFO - 'enabled': True, 04:25:02 INFO - 'halt_on_failure': False, 04:25:02 INFO - 'name': 'check_screen_resolution'},), 04:25:02 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:25:02 INFO - 'cmd': ('bash', 04:25:02 INFO - '-c', 04:25:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:25:02 INFO - 'enabled': True, 04:25:02 INFO - 'halt_on_failure': False, 04:25:02 INFO - 'name': 'check_screen_resolution'},), 04:25:02 INFO - 'run_cmd_checks_enabled': True, 04:25:02 INFO - 'sps_profile': False, 04:25:02 INFO - 'sps_profile_interval': 0, 04:25:02 INFO - 'suite': 'dromaeojs-e10s', 04:25:02 INFO - 'system_bits': '32', 04:25:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:25:02 INFO - 'title': 't-yosemite-r7-0244', 04:25:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:25:02 INFO - 'use_talos_json': True, 04:25:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:25:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:25:02 INFO - 'work_dir': 'build'} 04:25:02 INFO - [mozharness: 2017-01-15 12:25:02.604292Z] Running clobber step. 04:25:02 INFO - Running pre-action listener: _resource_record_pre_action 04:25:02 INFO - Running main action method: clobber 04:25:02 INFO - rmtree: /builds/slave/test/build 04:25:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:25:04 INFO - Running post-action listener: _resource_record_post_action 04:25:04 INFO - [mozharness: 2017-01-15 12:25:04.613194Z] Finished clobber step (success) 04:25:04 INFO - [mozharness: 2017-01-15 12:25:04.613324Z] Running read-buildbot-config step. 04:25:04 INFO - Running pre-action listener: _resource_record_pre_action 04:25:04 INFO - Running main action method: read_buildbot_config 04:25:04 INFO - Using buildbot properties: 04:25:04 INFO - { 04:25:04 INFO - "project": "", 04:25:04 INFO - "product": "firefox", 04:25:04 INFO - "script_repo_revision": "production", 04:25:04 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 04:25:04 INFO - "repository": "", 04:25:04 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 04:25:04 INFO - "buildid": "20170115030210", 04:25:04 INFO - "stage_platform": "macosx64", 04:25:04 INFO - "basedir": "/builds/slave/test", 04:25:04 INFO - "nightly_build": "True", 04:25:04 INFO - "buildnumber": 37, 04:25:04 INFO - "slavename": "t-yosemite-r7-0244", 04:25:04 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 04:25:04 INFO - "platform": "yosemite_r7", 04:25:04 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:25:04 INFO - "branch": "mozilla-central", 04:25:04 INFO - "repo_path": "mozilla-central", 04:25:04 INFO - "revision": "5ce3882eec21be3a70e4afc050959ca2f76bfa76", 04:25:04 INFO - "pgo_build": "False", 04:25:04 INFO - "builduid": "ccd28d71259f477eb807d96d7db7334d", 04:25:04 INFO - "slavebuilddir": "test" 04:25:04 INFO - } 04:25:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/IyJWPtNKTZ-8r6FAqikyLA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 04:25:04 INFO - Running post-action listener: _resource_record_post_action 04:25:04 INFO - [mozharness: 2017-01-15 12:25:04.616774Z] Finished read-buildbot-config step (success) 04:25:04 INFO - [mozharness: 2017-01-15 12:25:04.616889Z] Running download-and-extract step. 04:25:04 INFO - Running pre-action listener: _resource_record_pre_action 04:25:04 INFO - Running main action method: download_and_extract 04:25:04 INFO - mkdir: /builds/slave/test/build/tests 04:25:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:04 INFO - trying https://queue.taskcluster.net/v1/task/IyJWPtNKTZ-8r6FAqikyLA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 04:25:04 INFO - Downloading https://queue.taskcluster.net/v1/task/IyJWPtNKTZ-8r6FAqikyLA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 04:25:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IyJWPtNKTZ-8r6FAqikyLA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 04:25:05 INFO - Downloaded 1199 bytes. 04:25:05 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 04:25:05 INFO - Using the following test package requirements: 04:25:05 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 04:25:05 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:25:05 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 04:25:05 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:25:05 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 04:25:05 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:25:05 INFO - u'jsshell-mac.zip'], 04:25:05 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:25:05 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 04:25:05 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 04:25:05 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:25:05 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 04:25:05 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:25:05 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 04:25:05 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:25:05 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 04:25:05 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:25:05 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 04:25:05 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:25:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IyJWPtNKTZ-8r6FAqikyLA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 04:25:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IyJWPtNKTZ-8r6FAqikyLA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:25:05 INFO - Fetch https://queue.taskcluster.net/v1/task/IyJWPtNKTZ-8r6FAqikyLA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 04:25:06 INFO - Expected file size: 16319157 04:25:06 INFO - Obtained file size: 16319157 04:25:13 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:25:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IyJWPtNKTZ-8r6FAqikyLA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 04:25:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IyJWPtNKTZ-8r6FAqikyLA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:25:13 INFO - Fetch https://queue.taskcluster.net/v1/task/IyJWPtNKTZ-8r6FAqikyLA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 04:25:14 INFO - Expected file size: 16319157 04:25:14 INFO - Obtained file size: 16319157 04:25:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IyJWPtNKTZ-8r6FAqikyLA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 04:25:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IyJWPtNKTZ-8r6FAqikyLA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:25:20 INFO - Fetch https://queue.taskcluster.net/v1/task/IyJWPtNKTZ-8r6FAqikyLA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 04:25:21 INFO - Expected file size: 14403463 04:25:21 INFO - Obtained file size: 14403463 04:25: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')]} 04:25:22 INFO - trying https://queue.taskcluster.net/v1/task/IyJWPtNKTZ-8r6FAqikyLA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 04:25:22 INFO - Downloading https://queue.taskcluster.net/v1/task/IyJWPtNKTZ-8r6FAqikyLA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 04:25:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IyJWPtNKTZ-8r6FAqikyLA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 04:25:24 INFO - Downloaded 70195349 bytes. 04:25:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IyJWPtNKTZ-8r6FAqikyLA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 04:25:24 INFO - mkdir: /builds/slave/test/properties 04:25:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:25:24 INFO - Writing to file /builds/slave/test/properties/build_url 04:25:24 INFO - Contents: 04:25:24 INFO - build_url:https://queue.taskcluster.net/v1/task/IyJWPtNKTZ-8r6FAqikyLA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 04:25:25 INFO - Running post-action listener: _resource_record_post_action 04:25:25 INFO - Running post-action listener: set_extra_try_arguments 04:25:25 INFO - [mozharness: 2017-01-15 12:25:25.285844Z] Finished download-and-extract step (success) 04:25:25 INFO - [mozharness: 2017-01-15 12:25:25.286008Z] Running populate-webroot step. 04:25:25 INFO - Running pre-action listener: _resource_record_pre_action 04:25:25 INFO - Running main action method: populate_webroot 04:25:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:25:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:25:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:25:25 INFO - '--tppagecycles', 04:25:25 INFO - '7'], 04:25:25 INFO - 'tests': ['tsvgm']}}, 04:25:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:25:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:25:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:25:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:25:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:25:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:25:25 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:25:25 INFO - 'talos_options': ['--disable-e10s'], 04:25:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:25:25 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:25:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:25:25 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:25:25 INFO - 'talos_options': ['--disable-e10s'], 04:25:25 INFO - 'tests': ['damp', 'tps']}, 04:25:25 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:25:25 INFO - 'tests': ['damp', 'tps']}, 04:25:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:25:25 INFO - 'tests': ['dromaeo_dom']}, 04:25:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:25:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:25:25 INFO - 'tests': ['basic_compositor_video']}, 04:25:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:25:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:25:25 INFO - 'tests': ['a11yr', 04:25:25 INFO - 'ts_paint', 04:25:25 INFO - 'tpaint', 04:25:25 INFO - 'sessionrestore', 04:25:25 INFO - 'sessionrestore_no_auto_restore', 04:25:25 INFO - 'tabpaint']}, 04:25:25 INFO - 'other-e10s': {'tests': ['a11yr', 04:25:25 INFO - 'ts_paint', 04:25:25 INFO - 'tpaint', 04:25:25 INFO - 'sessionrestore', 04:25:25 INFO - 'sessionrestore_no_auto_restore', 04:25:25 INFO - 'tabpaint']}, 04:25:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:25:25 INFO - 'ts_paint', 04:25:25 INFO - 'tpaint', 04:25:25 INFO - 'sessionrestore', 04:25:25 INFO - 'sessionrestore_no_auto_restore', 04:25:25 INFO - 'tabpaint']}, 04:25:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:25:25 INFO - 'ts_paint', 04:25:25 INFO - 'tpaint', 04:25:25 INFO - 'sessionrestore', 04:25:25 INFO - 'sessionrestore_no_auto_restore', 04:25:25 INFO - 'tabpaint']}, 04:25:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:25:25 INFO - 'tests': ['a11yr', 04:25:25 INFO - 'ts_paint', 04:25:25 INFO - 'tpaint', 04:25:25 INFO - 'sessionrestore', 04:25:25 INFO - 'sessionrestore_no_auto_restore', 04:25:25 INFO - 'tabpaint']}, 04:25:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:25:25 INFO - 'tests': ['a11yr', 04:25:25 INFO - 'ts_paint', 04:25:25 INFO - 'tpaint', 04:25:25 INFO - 'sessionrestore', 04:25:25 INFO - 'sessionrestore_no_auto_restore', 04:25:25 INFO - 'tabpaint']}, 04:25:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:25:25 INFO - 'tests': ['tsvgx', 04:25:25 INFO - 'tsvgr_opacity', 04:25:25 INFO - 'tart', 04:25:25 INFO - 'tscrollx', 04:25:25 INFO - 'cart', 04:25:25 INFO - 'tsvg_static']}, 04:25:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:25:25 INFO - 'tsvgr_opacity', 04:25:25 INFO - 'tart', 04:25:25 INFO - 'tscrollx', 04:25:25 INFO - 'cart', 04:25:25 INFO - 'tsvg_static']}, 04:25:25 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:25:25 INFO - 'talos_options': ['--disable-e10s'], 04:25:25 INFO - 'tests': ['tp5o']}, 04:25:25 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:25:25 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:25:25 INFO - 'talos_options': ['--disable-e10s', 04:25:25 INFO - '--xperf_path', 04:25:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:25:25 INFO - 'tests': ['tp5n']}, 04:25:25 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:25:25 INFO - 'talos_options': ['--xperf_path', 04:25:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:25:25 INFO - 'tests': ['tp5n']}}, 04:25:25 INFO - 'talos.zip': {'path': '', 04:25:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:25:25 INFO - Running post-action listener: _resource_record_post_action 04:25:25 INFO - [mozharness: 2017-01-15 12:25:25.304196Z] Finished populate-webroot step (success) 04:25:25 INFO - [mozharness: 2017-01-15 12:25:25.304298Z] Running create-virtualenv step. 04:25:25 INFO - Running pre-action listener: _resource_record_pre_action 04:25:25 INFO - Running main action method: create_virtualenv 04:25:25 INFO - Creating virtualenv /builds/slave/test/build/venv 04:25:25 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:25:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:25:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:25:25 INFO - Using real prefix '/tools/python27' 04:25:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:25:26 INFO - Installing distribute.............................................................................................................................................................................................done. 04:25:28 INFO - Installing pip.................done. 04:25:29 INFO - Return code: 0 04:25:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:25:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:25:29 INFO - Reading from file tmpfile_stdout 04:25:29 INFO - Output received: 04:25:29 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:25:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:25:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:29 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 0x10c679b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c67c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdcd0c6a570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c457d30>, '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 0x10c37edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c44cbe8>, '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.pco38WBinJ/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.pgb5FQgZm4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:25:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:25:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:25:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pco38WBinJ/Render', 04:25:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:25:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:25:29 INFO - 'HOME': '/Users/cltbld', 04:25:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:25:29 INFO - 'LOGNAME': 'cltbld', 04:25:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:29 INFO - 'MOZ_NO_REMOTE': '1', 04:25:29 INFO - 'NO_EM_RESTART': '1', 04:25:29 INFO - 'PAGER': '/bin/cat', 04:25:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:25:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:29 INFO - 'PWD': '/builds/slave/test', 04:25:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:25:29 INFO - 'SHELL': '/bin/bash', 04:25:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pgb5FQgZm4/Listeners', 04:25:29 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 04:25:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:25:29 INFO - 'USER': 'cltbld', 04:25:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:25:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:25:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:29 INFO - 'XPC_FLAGS': '0x0', 04:25:29 INFO - 'XPC_SERVICE_NAME': '0', 04:25:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:25:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:29 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:25:29 INFO - Cleaning up... 04:25:29 INFO - Return code: 0 04:25:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:25:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:29 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 0x10c679b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c67c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdcd0c6a570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c457d30>, '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 0x10c37edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c44cbe8>, '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.pco38WBinJ/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.pgb5FQgZm4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:25:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:25:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:25:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pco38WBinJ/Render', 04:25:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:25:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:25:29 INFO - 'HOME': '/Users/cltbld', 04:25:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:25:29 INFO - 'LOGNAME': 'cltbld', 04:25:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:29 INFO - 'MOZ_NO_REMOTE': '1', 04:25:29 INFO - 'NO_EM_RESTART': '1', 04:25:29 INFO - 'PAGER': '/bin/cat', 04:25:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:25:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:29 INFO - 'PWD': '/builds/slave/test', 04:25:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:25:29 INFO - 'SHELL': '/bin/bash', 04:25:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pgb5FQgZm4/Listeners', 04:25:29 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 04:25:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:25:29 INFO - 'USER': 'cltbld', 04:25:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:25:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:25:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:29 INFO - 'XPC_FLAGS': '0x0', 04:25:29 INFO - 'XPC_SERVICE_NAME': '0', 04:25:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:25:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:29 INFO - Downloading/unpacking psutil>=3.1.1 04:25:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:25:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:25:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:25:33 INFO - Installing collected packages: psutil 04:25:33 INFO - Running setup.py install for psutil 04:25:33 INFO - building 'psutil._psutil_osx' extension 04:25:33 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:25:34 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:25:34 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:25:34 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:25:34 INFO - building 'psutil._psutil_posix' extension 04:25:34 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:25:34 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:25:34 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:25:34 INFO - ^ 04:25:34 INFO - 1 warning generated. 04:25:34 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:25:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:25:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:25:34 INFO - Successfully installed psutil 04:25:34 INFO - Cleaning up... 04:25:34 INFO - Return code: 0 04:25:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:25:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:34 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 0x10c679b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c67c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdcd0c6a570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c457d30>, '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 0x10c37edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c44cbe8>, '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.pco38WBinJ/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.pgb5FQgZm4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:25:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:25:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:25:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pco38WBinJ/Render', 04:25:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:25:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:25:34 INFO - 'HOME': '/Users/cltbld', 04:25:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:25:34 INFO - 'LOGNAME': 'cltbld', 04:25:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:34 INFO - 'MOZ_NO_REMOTE': '1', 04:25:34 INFO - 'NO_EM_RESTART': '1', 04:25:34 INFO - 'PAGER': '/bin/cat', 04:25:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:25:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:34 INFO - 'PWD': '/builds/slave/test', 04:25:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:25:34 INFO - 'SHELL': '/bin/bash', 04:25:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pgb5FQgZm4/Listeners', 04:25:34 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 04:25:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:25:34 INFO - 'USER': 'cltbld', 04:25:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:25:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:25:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:34 INFO - 'XPC_FLAGS': '0x0', 04:25:34 INFO - 'XPC_SERVICE_NAME': '0', 04:25:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:25:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:25:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:25:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:25:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:25:37 INFO - Installing collected packages: mozsystemmonitor 04:25:37 INFO - Running setup.py install for mozsystemmonitor 04:25:37 INFO - Successfully installed mozsystemmonitor 04:25:37 INFO - Cleaning up... 04:25:37 INFO - Return code: 0 04:25:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:25:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:37 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 0x10c679b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c67c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdcd0c6a570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c457d30>, '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 0x10c37edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c44cbe8>, '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.pco38WBinJ/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.pgb5FQgZm4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:25:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:25:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:25:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pco38WBinJ/Render', 04:25:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:25:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:25:37 INFO - 'HOME': '/Users/cltbld', 04:25:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:25:37 INFO - 'LOGNAME': 'cltbld', 04:25:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:37 INFO - 'MOZ_NO_REMOTE': '1', 04:25:37 INFO - 'NO_EM_RESTART': '1', 04:25:37 INFO - 'PAGER': '/bin/cat', 04:25:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:25:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:37 INFO - 'PWD': '/builds/slave/test', 04:25:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:25:37 INFO - 'SHELL': '/bin/bash', 04:25:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pgb5FQgZm4/Listeners', 04:25:37 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 04:25:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:25:37 INFO - 'USER': 'cltbld', 04:25:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:25:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:25:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:37 INFO - 'XPC_FLAGS': '0x0', 04:25:37 INFO - 'XPC_SERVICE_NAME': '0', 04:25:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:25:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:38 INFO - Downloading/unpacking jsonschema==2.5.1 04:25:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:25:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:25:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:41 INFO - Downloading functools32-3.2.3-2.tar.gz 04:25:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:25:41 INFO - warning: no files found matching '*.txt' 04:25:41 INFO - no previously-included directories found matching 'build' 04:25:41 INFO - no previously-included directories found matching 'dist' 04:25:41 INFO - no previously-included directories found matching '.git*' 04:25:41 INFO - Installing collected packages: jsonschema, functools32 04:25:41 INFO - Running setup.py install for functools32 04:25:41 INFO - warning: no files found matching '*.txt' 04:25:41 INFO - no previously-included directories found matching 'build' 04:25:41 INFO - no previously-included directories found matching 'dist' 04:25:41 INFO - no previously-included directories found matching '.git*' 04:25:41 INFO - Successfully installed jsonschema functools32 04:25:41 INFO - Cleaning up... 04:25:41 INFO - Return code: 0 04:25:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:25:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c679b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c67c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdcd0c6a570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c457d30>, '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 0x10c37edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c44cbe8>, '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.pco38WBinJ/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.pgb5FQgZm4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:25:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:25:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:25:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pco38WBinJ/Render', 04:25:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:25:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:25:41 INFO - 'HOME': '/Users/cltbld', 04:25:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:25:41 INFO - 'LOGNAME': 'cltbld', 04:25:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:41 INFO - 'MOZ_NO_REMOTE': '1', 04:25:41 INFO - 'NO_EM_RESTART': '1', 04:25:41 INFO - 'PAGER': '/bin/cat', 04:25:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:25:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:41 INFO - 'PWD': '/builds/slave/test', 04:25:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:25:41 INFO - 'SHELL': '/bin/bash', 04:25:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pgb5FQgZm4/Listeners', 04:25:41 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 04:25:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:25:41 INFO - 'USER': 'cltbld', 04:25:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:25:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:25:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:41 INFO - 'XPC_FLAGS': '0x0', 04:25:41 INFO - 'XPC_SERVICE_NAME': '0', 04:25:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:25:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:25:41 INFO - Cleaning up... 04:25:41 INFO - Return code: 0 04:25:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:25:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c679b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c67c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdcd0c6a570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c457d30>, '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 0x10c37edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c44cbe8>, '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.pco38WBinJ/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.pgb5FQgZm4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:25:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:25:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:25:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pco38WBinJ/Render', 04:25:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:25:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:25:41 INFO - 'HOME': '/Users/cltbld', 04:25:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:25:41 INFO - 'LOGNAME': 'cltbld', 04:25:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:41 INFO - 'MOZ_NO_REMOTE': '1', 04:25:41 INFO - 'NO_EM_RESTART': '1', 04:25:41 INFO - 'PAGER': '/bin/cat', 04:25:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:25:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:41 INFO - 'PWD': '/builds/slave/test', 04:25:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:25:41 INFO - 'SHELL': '/bin/bash', 04:25:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pgb5FQgZm4/Listeners', 04:25:41 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 04:25:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:25:41 INFO - 'USER': 'cltbld', 04:25:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:25:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:25:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:41 INFO - 'XPC_FLAGS': '0x0', 04:25:41 INFO - 'XPC_SERVICE_NAME': '0', 04:25:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:25:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:42 INFO - Downloading/unpacking blobuploader==1.2.4 04:25:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:44 INFO - Downloading blobuploader-1.2.4.tar.gz 04:25:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:25:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:25:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:25:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:25:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:45 INFO - Downloading docopt-0.6.1.tar.gz 04:25:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:25:46 INFO - Installing collected packages: blobuploader, requests, docopt 04:25:46 INFO - Running setup.py install for blobuploader 04:25:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:25:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:25:46 INFO - Running setup.py install for requests 04:25:46 INFO - Running setup.py install for docopt 04:25:46 INFO - Successfully installed blobuploader requests docopt 04:25:46 INFO - Cleaning up... 04:25:46 INFO - Return code: 0 04:25:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:25:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:46 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 0x10c679b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c67c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdcd0c6a570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c457d30>, '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 0x10c37edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c44cbe8>, '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.pco38WBinJ/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.pgb5FQgZm4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:25:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:25:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:25:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pco38WBinJ/Render', 04:25:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:25:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:25:46 INFO - 'HOME': '/Users/cltbld', 04:25:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:25:46 INFO - 'LOGNAME': 'cltbld', 04:25:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:46 INFO - 'MOZ_NO_REMOTE': '1', 04:25:46 INFO - 'NO_EM_RESTART': '1', 04:25:46 INFO - 'PAGER': '/bin/cat', 04:25:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:25:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:46 INFO - 'PWD': '/builds/slave/test', 04:25:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:25:46 INFO - 'SHELL': '/bin/bash', 04:25:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pgb5FQgZm4/Listeners', 04:25:46 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 04:25:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:25:46 INFO - 'USER': 'cltbld', 04:25:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:25:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:25:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:46 INFO - 'XPC_FLAGS': '0x0', 04:25:46 INFO - 'XPC_SERVICE_NAME': '0', 04:25:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:25:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:25:47 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-X2Bq_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:25:47 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-I8JK9v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:25:47 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-k4Au8D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:25:47 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-gHc7NF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:25:47 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-nRkZEH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:25:47 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-XKkui9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:25:47 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-lGjvxC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:25:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:25:47 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-yEOggN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:25:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:25:48 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-72agEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:25:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:25:48 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-DOLAIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:25:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:25:48 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-Ekt8Lx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:25:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:25:48 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-moZas8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:25:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:25:48 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-XNulCM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:25:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:25:48 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-NInGPU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:25:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:25:48 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-Sl2rqT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:25:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:25:48 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-XVMrJm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:25:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:25:48 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-Vckh5F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:25:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:25:48 INFO - Running setup.py install for manifestparser 04:25:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:25:49 INFO - Running setup.py install for mozcrash 04:25:49 INFO - Running setup.py install for mozdebug 04:25:49 INFO - Running setup.py install for mozdevice 04:25:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:25:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:25:49 INFO - Running setup.py install for mozfile 04:25:49 INFO - Running setup.py install for mozhttpd 04:25:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:25:49 INFO - Running setup.py install for mozinfo 04:25:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:25:50 INFO - Running setup.py install for mozInstall 04:25:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:25:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:25:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:25:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:25:50 INFO - Running setup.py install for mozleak 04:25:50 INFO - Running setup.py install for mozlog 04:25:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:25:50 INFO - Running setup.py install for moznetwork 04:25:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:25:50 INFO - Running setup.py install for mozprocess 04:25:50 INFO - Running setup.py install for mozprofile 04:25:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:25:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:25:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:25:50 INFO - Running setup.py install for mozrunner 04:25:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:25:51 INFO - Running setup.py install for mozscreenshot 04:25:51 INFO - Running setup.py install for moztest 04:25:51 INFO - Running setup.py install for mozversion 04:25:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:25:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:25:51 INFO - Cleaning up... 04:25:51 INFO - Return code: 0 04:25:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:25:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:51 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 0x10c679b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c67c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdcd0c6a570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c457d30>, '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 0x10c37edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c44cbe8>, '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.pco38WBinJ/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.pgb5FQgZm4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:25:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:25:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:25:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pco38WBinJ/Render', 04:25:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:25:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:25:51 INFO - 'HOME': '/Users/cltbld', 04:25:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:25:51 INFO - 'LOGNAME': 'cltbld', 04:25:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:51 INFO - 'MOZ_NO_REMOTE': '1', 04:25:51 INFO - 'NO_EM_RESTART': '1', 04:25:51 INFO - 'PAGER': '/bin/cat', 04:25:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:25:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:51 INFO - 'PWD': '/builds/slave/test', 04:25:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:25:51 INFO - 'SHELL': '/bin/bash', 04:25:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pgb5FQgZm4/Listeners', 04:25:51 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 04:25:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:25:51 INFO - 'USER': 'cltbld', 04:25:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:25:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:25:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:51 INFO - 'XPC_FLAGS': '0x0', 04:25:51 INFO - 'XPC_SERVICE_NAME': '0', 04:25:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:25:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:25:51 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-BbT9yF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:25:51 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:25:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:25:51 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-U1JyR2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:25:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:25:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:25:52 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-OISx6X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:25:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:25:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:25:52 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-H5Tlg6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:25:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:25:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:25:52 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-IJoqYq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:25:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:25:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:25:52 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-nZeiUd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:25:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:25:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:25:52 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-n0VECA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:25:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:25:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:25:52 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-VluyBP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:25:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:25:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:25:52 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-VetVTq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:25:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:25:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:25:52 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-lXqAZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:25:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:25:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:25:52 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-738kBF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:25:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:25:53 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-rhWmvK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:25:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:25:53 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-QuRcRv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:25:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:25:53 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-iVSbhB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:25:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:25:53 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-qiciEV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:25:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:25:53 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-j3fZhI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:25:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:25:53 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-KMVvW6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:25:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:25:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:25:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:25:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:25:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:25:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:25:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:25:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:56 INFO - Downloading blessings-1.6.tar.gz 04:25:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:25:56 INFO - Installing collected packages: blessings 04:25:56 INFO - Running setup.py install for blessings 04:25:56 INFO - Successfully installed blessings 04:25:56 INFO - Cleaning up... 04:25:56 INFO - Return code: 0 04:25:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:25:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:25:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:25:56 INFO - Reading from file tmpfile_stdout 04:25:56 INFO - Current package versions: 04:25:56 INFO - blessings == 1.6 04:25:56 INFO - blobuploader == 1.2.4 04:25:56 INFO - docopt == 0.6.1 04:25:56 INFO - functools32 == 3.2.3-2 04:25:56 INFO - jsonschema == 2.5.1 04:25:56 INFO - manifestparser == 1.1 04:25:56 INFO - mozInstall == 1.12 04:25:56 INFO - mozcrash == 1.0 04:25:56 INFO - mozdebug == 0.1 04:25:56 INFO - mozdevice == 0.49 04:25:56 INFO - mozfile == 1.2 04:25:56 INFO - mozhttpd == 0.7 04:25:56 INFO - mozinfo == 0.9 04:25:56 INFO - mozleak == 0.1 04:25:56 INFO - mozlog == 3.4 04:25:56 INFO - moznetwork == 0.27 04:25:56 INFO - mozprocess == 0.24 04:25:56 INFO - mozprofile == 0.28 04:25:56 INFO - mozrunner == 6.13 04:25:56 INFO - mozscreenshot == 0.1 04:25:56 INFO - mozsystemmonitor == 0.3 04:25:56 INFO - moztest == 0.8 04:25:56 INFO - mozversion == 1.4 04:25:56 INFO - psutil == 3.1.1 04:25:56 INFO - requests == 1.2.3 04:25:56 INFO - wsgiref == 0.1.2 04:25:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:25:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:56 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 0x10c679b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c67c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdcd0c6a570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c457d30>, '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 0x10c37edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c44cbe8>, '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.pco38WBinJ/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.pgb5FQgZm4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:25:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:25:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:25:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pco38WBinJ/Render', 04:25:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:25:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:25:56 INFO - 'HOME': '/Users/cltbld', 04:25:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:25:56 INFO - 'LOGNAME': 'cltbld', 04:25:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:56 INFO - 'MOZ_NO_REMOTE': '1', 04:25:56 INFO - 'NO_EM_RESTART': '1', 04:25:56 INFO - 'PAGER': '/bin/cat', 04:25:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:25:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:56 INFO - 'PWD': '/builds/slave/test', 04:25:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:25:56 INFO - 'SHELL': '/bin/bash', 04:25:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pgb5FQgZm4/Listeners', 04:25:56 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 04:25:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:25:56 INFO - 'USER': 'cltbld', 04:25:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:25:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:25:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:56 INFO - 'XPC_FLAGS': '0x0', 04:25:56 INFO - 'XPC_SERVICE_NAME': '0', 04:25:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:25:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:25:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:25:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:25:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:25:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:25:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:25:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:25:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:25:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:25:57 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:25:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:25:57 INFO - Cleaning up... 04:25:57 INFO - Return code: 0 04:25:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:25:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:57 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 0x10c679b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c67c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdcd0c6a570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c457d30>, '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 0x10c37edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c44cbe8>, '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.pco38WBinJ/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.pgb5FQgZm4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:25:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:25:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:25:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pco38WBinJ/Render', 04:25:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:25:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:25:57 INFO - 'HOME': '/Users/cltbld', 04:25:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:25:57 INFO - 'LOGNAME': 'cltbld', 04:25:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:57 INFO - 'MOZ_NO_REMOTE': '1', 04:25:57 INFO - 'NO_EM_RESTART': '1', 04:25:57 INFO - 'PAGER': '/bin/cat', 04:25:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:25:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:57 INFO - 'PWD': '/builds/slave/test', 04:25:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:25:57 INFO - 'SHELL': '/bin/bash', 04:25:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pgb5FQgZm4/Listeners', 04:25:57 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 04:25:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:25:57 INFO - 'USER': 'cltbld', 04:25:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:25:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:25:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:57 INFO - 'XPC_FLAGS': '0x0', 04:25:57 INFO - 'XPC_SERVICE_NAME': '0', 04:25:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:25:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:25:57 INFO - Cleaning up... 04:25:57 INFO - Return code: 0 04:25:57 INFO - Running post-action listener: _resource_record_post_action 04:25:57 INFO - Running post-action listener: _start_resource_monitoring 04:25:57 INFO - Starting resource monitoring. 04:25:57 INFO - [mozharness: 2017-01-15 12:25:57.542288Z] Finished create-virtualenv step (success) 04:25:57 INFO - [mozharness: 2017-01-15 12:25:57.543248Z] Running install step. 04:25:57 INFO - Running pre-action listener: _resource_record_pre_action 04:25:57 INFO - Running main action method: install 04:25:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:25:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:25:57 INFO - Reading from file tmpfile_stdout 04:25:57 INFO - Detecting whether we're running mozinstall >=1.0... 04:25:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:25:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:25:57 INFO - Reading from file tmpfile_stdout 04:25:57 INFO - Output received: 04:25:57 INFO - Usage: mozinstall [options] installer 04:25:57 INFO - Options: 04:25:57 INFO - -h, --help show this help message and exit 04:25:57 INFO - -d DEST, --destination=DEST 04:25:57 INFO - Directory to install application into. [default: 04:25:57 INFO - "/builds/slave/test"] 04:25:57 INFO - --app=APP Application being installed. [default: firefox] 04:25:57 INFO - mkdir: /builds/slave/test/build/application 04:25:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:25:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:26:20 INFO - Reading from file tmpfile_stdout 04:26:20 INFO - Output received: 04:26:20 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 04:26:20 INFO - Running post-action listener: _resource_record_post_action 04:26:20 INFO - [mozharness: 2017-01-15 12:26:20.172701Z] Finished install step (success) 04:26:20 INFO - [mozharness: 2017-01-15 12:26:20.172835Z] Running run-tests step. 04:26:20 INFO - Running pre-action listener: _resource_record_pre_action 04:26:20 INFO - Running main action method: run_tests 04:26:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:26:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:26:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:26:20 INFO - 2017-01-15 04:26:20.187 screenresolution[1997:13617] starting screenresolution argv=screenresolution get 04:26:20 INFO - 2017-01-15 04:26:20.189 screenresolution[1997:13617] Display 0: 1600x1200x32@60 04:26:20 INFO - 2017-01-15 04:26:20.195 screenresolution[1998:13619] starting screenresolution argv=screenresolution list 04:26:20 INFO - Available Modes on Display 0 04:26:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:26:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:26:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:26:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:26:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:26:20 INFO - Intel Iris: 04:26:20 INFO - Chipset Model: Intel Iris 04:26:20 INFO - Type: GPU 04:26:20 INFO - Bus: Built-In 04:26:20 INFO - VRAM (Dynamic, Max): 1536 MB 04:26:20 INFO - Vendor: Intel (0x8086) 04:26:20 INFO - Device ID: 0x0a2e 04:26:20 INFO - Revision ID: 0x0009 04:26:20 INFO - Displays: 04:26:20 INFO - Display: 04:26:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:26:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:26:20 INFO - Display Serial Number: 1600x1200 60 04:26:20 INFO - Main Display: Yes 04:26:20 INFO - Mirror: Off 04:26:20 INFO - Online: Yes 04:26:20 INFO - Rotation: Supported 04:26:20 INFO - Return code: 0 04:26:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:26:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:26:20 INFO - Python 2.7.3 04:26:20 INFO - Return code: 0 04:26:20 INFO - grabbing minidump binary from tooltool 04:26:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:26:20 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 0x10c457d30>, '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 0x10c37edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c44cbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:26:20 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:26:20 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:26:20 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:26:20 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:26:20 INFO - Return code: 0 04:26:20 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:26:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:26:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:26:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:26:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:26:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IyJWPtNKTZ-8r6FAqikyLA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0244', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:26:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IyJWPtNKTZ-8r6FAqikyLA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0244 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:26:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pco38WBinJ/Render', 04:26:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:26:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:26:20 INFO - 'HOME': '/Users/cltbld', 04:26:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:26:20 INFO - 'LOGNAME': 'cltbld', 04:26:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:26:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:26:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:20 INFO - 'MOZ_NO_REMOTE': '1', 04:26:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:26:20 INFO - 'NO_EM_RESTART': '1', 04:26:20 INFO - 'PAGER': '/bin/cat', 04:26:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:26:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:20 INFO - 'PWD': '/builds/slave/test', 04:26:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:26:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:26:20 INFO - 'SHELL': '/bin/bash', 04:26:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pgb5FQgZm4/Listeners', 04:26:20 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 04:26:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:26:20 INFO - 'USER': 'cltbld', 04:26:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:26:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:26:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:20 INFO - 'XPC_FLAGS': '0x0', 04:26:20 INFO - 'XPC_SERVICE_NAME': '0', 04:26:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:26:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IyJWPtNKTZ-8r6FAqikyLA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0244', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:26:20 INFO - mozversion application_buildid: 20170115030210 04:26:20 INFO - mozversion application_changeset: 5ce3882eec21be3a70e4afc050959ca2f76bfa76 04:26:20 INFO - mozversion application_display_name: Nightly 04:26:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:26:20 INFO - mozversion application_name: Firefox 04:26:20 INFO - mozversion application_remotingname: firefox 04:26:20 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:26:20 INFO - mozversion application_vendor: Mozilla 04:26:20 INFO - mozversion application_version: 53.0a1 04:26:20 INFO - mozversion platform_buildid: 20170115030210 04:26:20 INFO - mozversion platform_changeset: 5ce3882eec21be3a70e4afc050959ca2f76bfa76 04:26:20 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:26:20 INFO - mozversion platform_version: 53.0a1 04:26:20 INFO - using testdate: 1484483180 04:26:20 INFO - actual date: 1484483180 04:26:20 INFO - starting webserver on 'localhost:49335' 04:26:20 INFO - SUITE-START | Running 2 tests 04:26:20 INFO - TEST-START | dromaeo_css 04:26:20 INFO - operating with platform_type : mac_ 04:26:20 INFO - Initialising browser for dromaeo_css test... 04:26:20 INFO - TEST-INFO | started process 2008 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/tmp5wsKhY/profile http://localhost:49335/getInfo.html) 04:26:23 INFO - PROCESS | 2008 | 2017-01-15 04:26:23.595 plugin-container[2010:13779] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x923f, name = 'com.apple.tsm.portname' 04:26:23 INFO - PROCESS | 2008 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:26:23 INFO - PROCESS | 2008 | 2017-01-15 04:26:23.595 plugin-container[2010:13779] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x970f, name = 'com.apple.CFPasteboardClient' 04:26:23 INFO - PROCESS | 2008 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:26:23 INFO - PROCESS | 2008 | 2017-01-15 04:26:23.595 plugin-container[2010:13779] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:26:23 INFO - PROCESS | 2008 | __metrics Screen width/height:1600/1200 04:26:23 INFO - PROCESS | 2008 | colorDepth:24 04:26:23 INFO - PROCESS | 2008 | Browser inner width/height: 1024/689 04:26:23 INFO - PROCESS | 2008 | __metrics 04:26:23 ERROR - PROCESS | 2008 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3249: TypeError: this.tabs is undefined 04:26:24 INFO - TEST-INFO | 2008: exit 0 04:26:24 INFO - Browser initialized. 04:26:24 INFO - Running cycle 1/1 for dromaeo_css test... 04:26:24 INFO - TEST-INFO | started process 2011 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/tmp5wsKhY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:26:26 INFO - PROCESS | 2011 | 2017-01-15 04:26:26.744 plugin-container[2012:13901] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x434b, name = 'com.apple.tsm.portname' 04:26:26 INFO - PROCESS | 2011 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:26:26 INFO - PROCESS | 2011 | 2017-01-15 04:26:26.745 plugin-container[2012:13901] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f03, name = 'com.apple.CFPasteboardClient' 04:26:26 INFO - PROCESS | 2011 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:26:26 INFO - PROCESS | 2011 | 2017-01-15 04:26:26.745 plugin-container[2012:13901] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:26:36 INFO - PROCESS | 2011 | RSS: Main: 233672704 04:26:36 INFO - PROCESS | 2011 | 04:29:39 INFO - PROCESS | 2011 | Cycle 1(1): loaded http://localhost:49335/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49335/tests/dromaeo/cssquery-ext.html) 04:29:40 INFO - PROCESS | 2011 | RSS: Main: 250564608 04:29:40 INFO - PROCESS | 2011 | 04:31:24 INFO - PROCESS | 2011 | ************************* 04:31:24 INFO - PROCESS | 2011 | A coding exception was thrown and uncaught in a Task. 04:31:24 INFO - PROCESS | 2011 | 04:31:24 ERROR - PROCESS | 2011 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:31:24 INFO - PROCESS | 2011 | Full stack: 04:31:24 INFO - PROCESS | 2011 | ************************* 04:32:43 INFO - PROCESS | 2011 | Cycle 1(1): loaded http://localhost:49335/tests/dromaeo/cssquery-ext.html (next: http://localhost:49335/tests/dromaeo/cssquery-jquery.html) 04:32:44 INFO - PROCESS | 2011 | RSS: Main: 261210112 04:32:44 INFO - PROCESS | 2011 | 04:35:45 INFO - PROCESS | 2011 | Cycle 1(1): loaded http://localhost:49335/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49335/tests/dromaeo/cssquery-mootools.html) 04:35:46 INFO - PROCESS | 2011 | RSS: Main: 268783616 04:35:46 INFO - PROCESS | 2011 | 04:38:48 INFO - PROCESS | 2011 | Cycle 1(1): loaded http://localhost:49335/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49335/tests/dromaeo/cssquery-prototype.html) 04:38:49 INFO - PROCESS | 2011 | RSS: Main: 265011200 04:38:49 INFO - PROCESS | 2011 | 04:41:51 INFO - PROCESS | 2011 | Cycle 1(1): loaded http://localhost:49335/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49335/tests/dromaeo/cssquery-yui.html) 04:41:52 INFO - PROCESS | 2011 | RSS: Main: 271593472 04:41:52 INFO - PROCESS | 2011 | 04:44:54 INFO - PROCESS | 2011 | Cycle 1(1): loaded http://localhost:49335/tests/dromaeo/cssquery-yui.html (next: http://localhost:49335/tests/dromaeo/cssquery-dojo.html) 04:44:55 INFO - PROCESS | 2011 | RSS: Main: 274853888 04:44:55 INFO - PROCESS | 2011 | 04:44:55 INFO - PROCESS | 2011 | __start_tp_report 04:44:55 INFO - PROCESS | 2011 | _x_x_mozilla_page_load 04:44:55 INFO - PROCESS | 2011 | _x_x_mozilla_page_load_details 04:44:55 INFO - PROCESS | 2011 | |i|pagename|runs| 04:44:55 INFO - PROCESS | 2011 | |0;dojo.html;3269.8855540056097;3328.8668453261885;3379.2396710740086;3382.560267165268;3392.304577561599;5632.295963004624;5758.4529469700365;5760.04959181735;5764.971175144124;5827.883442331162;4518.796654150563;5641.435856414367;5769.682667453289;5810.070388737803;5888.617239879415;5225.817096401626;5239.056969745444;5281.207818827168;5282.683039017671;5298.523132918037;5279.9208011879855;5338.492843179892;5350.30446042014;5378.973105134469;5381.784728610851;5327.813526526592;5343.171808369709;5348.304720386363;5353.84860843813;5423;5149.0216858797085;5154.433012368637;5203.557697595709;5208.635395522315;5251.186066159751;5145.716985565792;5163.509466600667;5211;5242.81650142247;5259.815906443256;4227.556106608792;5605.215269862222;5682.9486544988895;5740.856478588069;5770.04794208955;6107.856436553706;6126.724297406583;6133.82435864808;6148.6618235997;6166.691665416712;5144.974275128638;6122.947104152868;6196;6200.379962003809;6204.348543402923;5921.052631578927;5921.111833225008;5926.140709597084;5937.614055086406;5945.078512830518;5979.53501392153;6089;6287.937120628827;6302.086197501337;6319.747210111636;5396.9730151348995;6084.269887613426;6115.143879856823;6124.197855633957;6130.092410195535;6138.296437970408;6242.250929888442;6242.282137554149;6250;6253.874922501615;6134.00801433197;6135.110179431455;6136.447719705158;6137.4995631051315;6157.907631385533;6144.801763656044;6161.84595385119;6190.81427557174;6192.504599632019;6198.442140207403;4948.38145231846;4981.875453113701;5059.468755780664;5083.924225843385;5124.718140502308;4446.911061778746;4519.028408892104;4519.163954668397;4538.773061346919;4550.726956382628;4511.98480341927;5691.459311365414;5716.228309178207;5906.734196961147;5948.256467941507;5423.3491980962535;6231.9094158522985;6236.126942228092;6247.718852651642;6256.593321434092;4879.926801097987;5676.574256930747;5852.824415267549;5854.677992710442;5884.7940322088525;4590.770461476913;5426.864328391822;5484.314460692413;5500.3949565547755;5531.446855314517;6398.168238129199;6440.581362211441;6455.225372955276;6459.224893012869;6491.350864913471;6264.467520260647;6273.466755325666;6276.748930042747;6288.213973253343;6300.2754683212015;6199.752009919553;6201.007838745779;6246.281677606951;6460.418562329413;6504.772332968323;6128;6172.9505983981935;6184.474319682698;6194.101855230876;6197.752089916353;6226.221722284715;6231.2522497300615;6237.03325984455;6238.750449982132;6269.529785266032;4727.456342520654;5925.200097986889;5979.730912109053;6054.939450605438;6055.727492262947;6071.423214794588;6075.088736689532;6102.7619317136805;6171.105189747372;6171.6297022178815;5927.940720592739;5934.109883517507;6024.578279520391;6084.421979911901;6084.660046828098;6059.242594675666;6068.089786531879;6102.549845102896;6119.051547010221;6136.355682653257;6068.51451883857;6073.058675905242;6077.179580756541;6104.4505994460715;6119.510439164767 04:44:55 INFO - PROCESS | 2011 | |1;ext.html;455.6059008957251;465.3159855013129;474.9977547375038;482.83583581582275;487.37615851709813;32847.67152328476;39676.60323396765;41905.371419428695;42209.57790422095;42243.15513689724;42554.787226063905;43066;43574.56425435745;43635.47275845346;43769.12461750763;7597.620118994028;7830.804229894241;8572.14278572144;9092.22716069135;9345.2991025673;10370.429626370547;10749.731256718567;11144.498497567629;11426.028787553068;11633.476493557768;10491.895081049168;10653.573857045709;11355;11404.087672986141;11442.542298308057;9626.181774549172;11386.772264554746;11488.310701357945;11490.36802975836;11493.482793274323;11085.113190944705;11138.554457821678;11293.458971731377;11376.715582110432;11408.885911140866;40817.591824081675;40983.38524922128;41169.58830411688;41208.96977575555;41293.380599291035;4030.375291829771;4066.1664358806374;4133.565975572552;4151.792410379499;4226.492820861486;25353.61969570458;29661.110166694816;31450;31679.366412671618;31752.523712144335;3113.315070684446;3145.528170774402;3158.1630867820045;3161.7944833585975;3163.225009872573;440921;445723;487396;489162.55418723036;490951;62537;62962.37037629657;63146.36853631405;63171.368286316545;63270.683646582394;58894.70552647295;63556.41108972313;65720.34279657142;66369.33630663728;66839.66580167068;13198.934005330104;16322.428714995156;16346.75479867803;16372.345106195618;16381.672366552602;11125.276857004268;11394.715132121763;12197.878021219674;12315;12638.368081596067;16848.820582559103;17920.28318867257;19012.61974760497;19032.904835476013;19075.90462047681;5961.910571341434;6928.792136235921;6971.163460384786;7085.751998680022;7086.574805511686;870.5995242188537;890.0387581412059;890.2966656341547;892.3441270666056;929.1776777551916;24146;29369.7063029367;30388.240293992385;30600.54099188514;30904.845475772476;1057.3867157048894;1057.5241141486208;1096.155959910864;1110.816715241976;1195.9521619135137;15643;15647.295871685801;15828.76256856148;16218.270177842025;16398.934069285457;610598.4170870645;865393;878414;879406;879719.2028079637;53945;54544.72727636337;54566.72716636471;54573.45426545763;54627.907441851734;1424.5370254667275;1430.9069910455787;1460.547230358571;1464.4508309384194;1468.8249400479574;29005.564916525847;29030.41939161247;29101;29451.558226627047;29649;47283.763581181876;47625.76187119042;47644.76177619228;47654.52345476501;47814.043719124726;434993;465387;545396;546333.2683336717;546369;20126.09432575567;24449.144279950116;24988.50022999566;25028.62457063182;25331.873340633916;33208.1697957553;42291.154176915676;43118.35322470103;43871.12257754891;45523.77238113788;35951.64048359483;35962;36292;36925.44611830771;37190.628093719795;35398.29203415969;36356.727514537924;36466.63533364632;36878;37124.25751485009;35266.11834704153;35267;35633.57465701447;35859.282814344086;36161.45757813582;30940;32153.678463216005;32177;32259.70961161527;32374.83812580922;24249.87875060684;24359.75640243646;24414.87792561097;24719.887605058175;24906.87546562328 04:44:55 INFO - PROCESS | 2011 | |2;jquery.html;375.8778397020968;389.6940901392406;393;395.4384773621457;421.42054674822117;17115.74326385105;20283.797162028393;20566.383008509732;21276.574468510622;21297.467563310925;21150.57698846026;21159.471013224676;21162.788372116273;21536.13855445784;21603.243886463977;5699.344575373833;6046.304674962392;6063.878722425548;6066.817995460143;6067.332593414721;5709.286339207599;5832.475077243047;5906.26171728534;5948.583599148062;5952.88094238115;5892.410758924095;5903.940960590382;5909.704514774266;5912.940870591304;5948.107783832416;5640.830775076754;5799.710014499279;5833.183354330397;5881.558883083786;5930.318013428447;5177.58579313654;5181.171012637998;5189.377274727057;5191.428942816287;5218.478152184789;25698.871505642353;25913.61129583058;26045.088421905333;26063.73936260651;26386.340341491425;2657.946841063187;2709.2143278449225;2722.7821774258014;2750.35366688828;2757.352022274764;15724.842751572452;15966.521004369888;16073.955192912423;16089.839101609068;16572.58568535784;1738.4697667211497;1833.7982821889582;1834.110456428631;1861.6183682345086;1864.8041955594604;131069;133336.66663333436;134081;135433.64566354308;135592.999999999;9939.701808945743;10997.395143267036;11895.464704088337;11963.700907477209;12147.817782733266;11554.480048397842;14391;14725.926370368079;15776.76334854978;15800.36798528069;8352.540610266493;8648.783780405414;8737.650493980169;8764.255038321815;8816.382853200343;8516.74449766508;8527.658893644184;8540.40217184791;8544.444611100258;8696.695615653422;4789.353437285991;4881.780319885614;4894.828680996148;4902.583280421133;4951.331570238044;2031.4515080928068;2059.7013433052125;2064.834813214939;2065.83926592311;2072.668373060303;1003.8393856982848;1005.4419797012728;1015.3552494166257;1016.1261315268863;1055.5302890213934;21038.78961210399;21550.892245538984;21564;21654.783452165593;21909.890450547646;1024.6721049264313;1032.442481060219;1045.7856139491387;1055.5091882274778;1083.4366129612558;10128;10868.347899126078;11129.054030407344;11154.051905587954;11183.72040698989;712046;712674.4366278135;716053;726996;731006;147972;155003;155179;156256.43743562646;158051;983.7934033852828;990.8761404824397;1009.0414106598761;1014.3356101753216;1018.2057994764095;19020.619587607893;19101.713474298176;19138.330158444387;19185.808141918962;19208.615827683647;57506.42493575011;57971.84056318934;58053.83892322046;58182.127268091856;58216;83612.58193708993;84055;84163;84525;85750.57124714337;7259.676903390864;8381.664733410595;8394.706185283485;8676.956615216883;8696.739097827076;10367.27429079957;12930.741385172432;12933.676658083623;12950.222986620833;13346.13250138738;9716.028397160228;9915.058069483388;10880.945595271973;11080.670319561705;11493;9609.807803843743;9748.756281092747;11002.50488727993;11162.939520745516;11507.021903137993;11310.660680179608;11597.88402115968;11724.355160466257;11795.469203885674;11897.94051029774;6489.253735820441;8480.15198480147;8533.487990720576;8537.53043582584;8692.130786921258;8469.407141500036;10840.891591083988;11444.141689373164;11451.427428628702;11533.015704257097 04:44:55 INFO - PROCESS | 2011 | |3;mootools.html;1442.3941944383357;1479.8816094712417;1485.420685932486;1489.2181604657553;1503.654159543305;7585.013948186742;7626.733064342756;7826.217378262171;8129.309008734257;8261.132581078982;8076.434649574532;8363.623636936338;8373.539455329954;8474.194951479614;8482.321414286858;2077.1379877350882;2299.4596269876565;2352.8235382346393;2358.988205058981;2366.5030343627773;2332.1604222479896;2339.8713070781187;2374.750651181627;2387.7254115776736;2387.844790088647;2313.3406979010983;2323.6049871521795;2343.1330407749156;2343.824213184018;2345.5074434368803;2280.931572052833;2302.9539409211807;2308.3305841306;2331.661909023182;2339.0059224829465;2316.3514216019544;2329.650552417134;2347.3779448446176;2347.929562113139;2352.388379021467;8377.246047855722;8446.408751387406;8449.493030418194;8459.365547583895;8496.150384961516;5065.138926382524;5234.476552344773;5240.842774716764;5242.135047717122;5247.39654939683;3236.838158092086;3259.3970115528464;3461.2039230977016;3493.580770307554;3507.333606614735;1107.5514416661265;1109.6948339206701;1151.9596814111467;1157.1437136519;1180.3685028509706;10725.195610329178;10763.784724305548;10857.945710271399;10872.782544349147;10890.891091089066;4460.710053846489;4699.929501057487;4732.0772449372735;4773.761311934459;4785.449673287547;9406.153446189739;9528.761780955532;9542.950275469693;9549.61801527945;9555.23558115349;4618.468876079227;5252.9737351313;5283.471652834763;5286.286351342519;5309.495597918191;3978.4430179774854;4189.706720529594;4734.573888350065;4760.928586071212;4870.366852309248;3376.898693039213;3656.104254457675;3884.397918322608;3910.413437984325;3954.051027753376;1306.8497122830806;1310.1614966421498;1314.1392387985884;1315;1333.300017490825;866.7096522664978;868.2880038368603;879.6349514951223;894.735282789681;913.7350168451075;5329.147336426231;5338.145896656516;5551.111822108524;5564.026295398289;5601.019821531216;537.9919301210485;538.4104405675779;552.9723513824292;566.0688167963676;570.3697414357158;3599.352116618981;3659.890203293852;3706.184639379332;3774.2640185164178;3805.9429108563395;9630.133288004114;9954.153896918699;9966.2525310602;9968.302218844756;9987.550560224807;9877.357971731815;9917.206623470105;9935.205183585296;9946.403215807075;9978.700638980843;7670.4247181461615;7736.7678969631;7784.9610751945875;7888.487248328955;7963.084245311863;5291.523762861361;5441.972790136024;5496.615236933376;5599.496045355774;5637.041702910433;7596;9242;9307.76730581741;9339.112784285482;9342.486163261086;9208.447493150432;9424.340296179202;9443.575039123118;9493.572789224363;9515.952420237854;6593.208814942238;6770.1537307836525;6951.123196736751;7089.680964356513;7178.461615378763;7782.260685234894;7978.361731061385;8046.959765201136;8050.154733753106;8053.31546818527;7054.611996340251;7141.571505709674;7206.243344448757;7211.927880721336;7277.9272207277245;6943.409810166192;7062.258462861326;7096.467764917755;7168.498205125591;7188;6239.438450539473;6259.96870015647;6327.90508142369;6328.398802113792;6331.683415829282;4921.114199444134;4964.032013757283;4977.502249775139;4995.075910956485;5040.193569028937;4833.468318485035;4894.92657610129;5006.4743201963265;5088.244555628302;5131.717755523482 04:44:55 INFO - PROCESS | 2011 | |4;prototype.html;323.3016683962643;346.4750902382889;357.1001077285241;367.470841987538;372.6571554170163;4369.438907290556;5026.522480364369;5090.592752579794;5308.787648494061;5523.861903452415;4554.931676024862;5367.645221736415;5394.244805727191;5435.2934118564535;5473.233747275384;3762.5673047599466;4021.4517410796907;4297.419848320484;4326.221280169569;4328.783560821947;3554.6800787929083;3926.5288165420047;4225.978870105645;4237.894052648693;4242.575742425748;4060.7157498975084;4171.4994200695955;4185.74885506869;4199;4201.243776120297;3544.5923718772415;3603.3153700796765;4247.851325203618;4271.572842715735;4275.850345237902;3162.7153556180056;3173.8571764270664;3194.3611277744544;3567.0061913321297;3753.4932784074344;4431.889202769924;4818.421789385261;5292.259083728281;5359.303290572239;5369.114096174127;4884.4871288514905;4903.411590609114;4904.803807847682;4927.7536123193695;4929.975350123263;5069.944044764174;5113.335266415379;5114.565261952701;5485.506304432581;5522.012075652762;3335.8332083395735;3823.044238940265;3923.6272554107313;3935.4490371347747;3964.365701487748;5311.336082989626;5320.127131349067;5573.857359241386;6121.693915304217;6182.96908515459;3776.2258736958856;3908;3941.467901833273;3941.586133455946;4004.6184066497012;3318.7510936679846;3687.391580389206;3994.840206391712;3998.8400463981698;4010.3984402339884;3914.4324073009825;4411.316245981878;4695.95304046962;4745.525447455227;4755.310479980383;4678;5522.641028333226;5556.333240011225;5879.735411906475;5904.881902362014;1091.7434402915308;1181.497863408048;1309.2079292028377;1318.8747069028427;1322.735452909422;768.8846672999094;832.8417600655856;835.7409203147043;845.5330002445752;881.457903389411;4316.525182229952;4379.781010949439;4534.183846907522;4547.136044151601;4991.057064918746;5247.842564723064;5278.155495120763;5665.490105890407;5804.026630945415;5959.986802243629;5187.247849061865;5327.866803329948;5389.568834493231;5463.617546771768;5488.231647569343;2493.90024399022;2705.891764329405;2800.6639203295736;2953.0697830183854;3005.5792189093545;5072.54347108762;5610.747516361692;5710.486056254957;5787.5080618147085;5990.251218597676;5278.445763194886;5343.251944727741;5658.603897727202;5737.512311453574;5868.972929737364;5125.564327032244;5711.371749107595;5717.739075712088;5858.765649374062;5996.370381110008;5041.706023759108;5205.58355331565;5677.858053548694;5786.363500015079;5804.941950580609;4732.834350797705;5068.746562671926;5174.844754657366;5597.832065038056;5687.578105473632;5352;5359.946400536101;5678.744456499385;5886.852828679317;5911.408859114054;3950.024987506247;3991.5808840071372;4057.8812505306546;4075.3683179107284;4090.795460227036;5145.92281115776;5588.804391846266;5612.579056570692;5678.517326027334;5745.425457454221;5184.5781784022365;5463.159157238134;5484.643498172606;5497.505224529811;5563.805266815642;4659.65052621048;5020.824271150492;5043.747812609428;5522.779088836402;5538.335399752055;4399.846005389924;5014.348134742606;5115.900081482499;5335.146376579729;5373.382061063028;4475.172093162775;5335.866603334947;5356.384015838073;5399.163129714901;5491.066518691752;5244.685318880879;5410.269613602113;5413;5639.689817060101;5724.454397312619 04:44:55 INFO - PROCESS | 2011 | |5;yui.html;720.4812534974819;736.8342123022318;736.9336759691629;776.7708525984834;823.460633285198;15418.61453463664;15963.328434460082;16045.518634440956;16105.27526261321;16112.194390280498;14727;14901.478448254313;14905.92547037266;14929.776053359208;14957.252137393141;681.1077488490081;705.3087973785667;856.6530555125153;877.1666916429385;877.784942689042;841.5287439034161;866.2723312417568;868.1275318305126;869.5826003518315;874.5802015032788;920.2316066084827;925.842606756853;932.883389576303;934.7522906429801;936.2229349639782;915.0712027292337;918.6004088221578;925.3799954030782;925.9768505787342;926.5413620257948;687.669918439152;688.1948120698794;688.5455599304435;689.4208864553799;691.1257259566652;14748.631284217872;15139.772903406458;15185.240737963057;15417.922910385489;15612;14165.858341416557;14466.92766536171;14552.126872387691;14624.853751462455;14634.268286585628;11728.237664551776;11747.47136378865;11748.236364636357;11785.292882427082;11799.94100029503;3679.5400574928135;3723.4600982857605;3742.3450896093345;3771.6039815819217;3787.0343062519155;83026.58486707589;100491.49754251182;105034.47482762537;106310.46844765804;107115.92884071215;10588.311759735592;10887.564497420015;11101.333919964827;11245.493952772145;11448.828267575993;17977.910110449364;22725.204617838295;23251.953662085245;23252.186173484184;23516.176933807234;7725.266099720518;7727.845443091219;7781.288116614336;7905.762827115196;8014.358851291882;4228.873133805991;4243.68172387066;4293.570642935744;4341.696081274281;4416.271315232951;3539.5398598182073;3602.603713591503;3627.673509384168;3636.7454278200803;3642.053066202753;498.9700617962934;634.7238951056305;637.353086617084;650.5478692308894;658.203573675848;665.6571865489277;690.3648643248224;701.7614011236102;710.5985118408083;728.4791374167389;9127.452352858716;9802.166815820592;10348.637797677045;10472.581096756197;10809.135269178447;591.0985746736176;650.8275307043542;671.5461026876854;672.4351544702473;701.8806802843427;4357.869263922087;4784.832530861473;5047.217681259411;5062.519060689228;5065.569426598707;84505.57747211224;95161.04838951521;98025;98296;99862;91494;92042.61936070964;92985.5350723242;95764;97213;65928.67035664887;68076;69349.61300773956;74533.25466745372;75291.87062194181;10443.634472793416;10743.946280268548;10954.507047182737;11046.898428113163;11055.944720276348;48440.75779621079;49611;50246;50727.49272507375;51638.483615163364;57586.56033599193;58629;60869;61696.38303617086;64076;13078.607641770763;13474.393652285475;13681.657958551115;13683.589492315246;13788.310584470937;14851.554453366416;14918.477853275517;14956.116783091493;15079.54761357161;15574.532764017098;13771;13811.654708632364;13939.581812545639;13966.720665586834;14317.57047288583;11504.884951150381;14000.299985000913;14013.089149205269;14283.64290892736;14458.493952711604;13186.472541098248;13369;13719.862801371859;13953.372098255806;14141.858581414053;11001.779964400826;11090.5563777448;11106.722331941766;11395.430228488376;11520.366379849189;9688.12806847387;10370.688879333633;11054.170937179582;11332.490037948477;11382.886171138514 04:44:55 INFO - PROCESS | 2011 | __end_tp_report 04:44:55 INFO - PROCESS | 2011 | __start_cc_report 04:44:55 INFO - PROCESS | 2011 | _x_x_mozilla_cycle_collect,381 04:44:55 INFO - PROCESS | 2011 | __end_cc_report 04:44:55 INFO - PROCESS | 2011 | __startTimestamp1484484295244__endTimestamp 04:44:55 INFO - PROCESS | 2011 | 04:44:55 INFO - PROCESS | 2011 | ------- Summary: start ------- 04:44:55 INFO - PROCESS | 2011 | Number of tests: 6 04:44:55 INFO - PROCESS | 2011 | 04:44:55 INFO - PROCESS | 2011 | [#0] dojo.html Cycles:165 Average:5721.38 Median:5979.54 stddev:660.37 (11.0%) stddev-sans-first:633.78 04:44:55 INFO - PROCESS | 2011 | Values: 3269.9 3328.9 3379.2 3382.6 3392.3 5632.3 5758.5 5760.0 5765.0 5827.9 4518.8 5641.4 5769.7 5810.1 5888.6 5225.8 5239.1 5281.2 5282.7 5298.5 5279.9 5338.5 5350.3 5379.0 5381.8 5327.8 5343.2 5348.3 5353.8 5423.0 5149.0 5154.4 5203.6 5208.6 5251.2 5145.7 5163.5 5211.0 5242.8 5259.8 4227.6 5605.2 5682.9 5740.9 5770.0 6107.9 6126.7 6133.8 6148.7 6166.7 5145.0 6122.9 6196.0 6200.4 6204.3 5921.1 5921.1 5926.1 5937.6 5945.1 5979.5 6089.0 6287.9 6302.1 6319.7 5397.0 6084.3 6115.1 6124.2 6130.1 6138.3 6242.3 6242.3 6250.0 6253.9 6134.0 6135.1 6136.4 6137.5 6157.9 6144.8 6161.8 6190.8 6192.5 6198.4 4948.4 4981.9 5059.5 5083.9 5124.7 4446.9 4519.0 4519.2 4538.8 4550.7 4512.0 5691.5 5716.2 5906.7 5948.3 5423.3 6231.9 6236.1 6247.7 6256.6 4879.9 5676.6 5852.8 5854.7 5884.8 4590.8 5426.9 5484.3 5500.4 5531.4 6398.2 6440.6 6455.2 6459.2 6491.4 6264.5 6273.5 6276.7 6288.2 6300.3 6199.8 6201.0 6246.3 6460.4 6504.8 6128.0 6173.0 6184.5 6194.1 6197.8 6226.2 6231.3 6237.0 6238.8 6269.5 4727.5 5925.2 5979.7 6054.9 6055.7 6071.4 6075.1 6102.8 6171.1 6171.6 5927.9 5934.1 6024.6 6084.4 6084.7 6059.2 6068.1 6102.5 6119.1 6136.4 6068.5 6073.1 6077.2 6104.5 6119.5 04:44:55 INFO - PROCESS | 2011 | 04:44:55 INFO - PROCESS | 2011 | [#1] ext.html Cycles:180 Average:72408.02 Median:35905.46 stddev:168151.81 (468.3%) stddev-sans-first:168536.74 04:44:55 INFO - PROCESS | 2011 | Values: 455.6 465.3 475.0 482.8 487.4 32847.7 39676.6 41905.4 42209.6 42243.2 42554.8 43066.0 43574.6 43635.5 43769.1 7597.6 7830.8 8572.1 9092.2 9345.3 10370.4 10749.7 11144.5 11426.0 11633.5 10491.9 10653.6 11355.0 11404.1 11442.5 9626.2 11386.8 11488.3 11490.4 11493.5 11085.1 11138.6 11293.5 11376.7 11408.9 40817.6 40983.4 41169.6 41209.0 41293.4 4030.4 4066.2 4133.6 4151.8 4226.5 25353.6 29661.1 31450.0 31679.4 31752.5 3113.3 3145.5 3158.2 3161.8 3163.2 440921.0 445723.0 487396.0 489162.6 490951.0 62537.0 62962.4 63146.4 63171.4 63270.7 58894.7 63556.4 65720.3 66369.3 66839.7 13198.9 16322.4 16346.8 16372.3 16381.7 11125.3 11394.7 12197.9 12315.0 12638.4 16848.8 17920.3 19012.6 19032.9 19075.9 5961.9 6928.8 6971.2 7085.8 7086.6 870.6 890.0 890.3 892.3 929.2 24146.0 29369.7 30388.2 30600.5 30904.8 1057.4 1057.5 1096.2 1110.8 1196.0 15643.0 15647.3 15828.8 16218.3 16398.9 610598.4 865393.0 878414.0 879406.0 879719.2 53945.0 54544.7 54566.7 54573.5 54627.9 1424.5 1430.9 1460.5 1464.5 1468.8 29005.6 29030.4 29101.0 29451.6 29649.0 47283.8 47625.8 47644.8 47654.5 47814.0 434993.0 465387.0 545396.0 546333.3 546369.0 20126.1 24449.1 24988.5 25028.6 25331.9 33208.2 42291.2 43118.4 43871.1 45523.8 35951.6 35962.0 36292.0 36925.4 37190.6 35398.3 36356.7 36466.6 36878.0 37124.3 35266.1 35267.0 35633.6 35859.3 36161.5 30940.0 32153.7 32177.0 32259.7 32374.8 24249.9 24359.8 24414.9 24719.9 24906.9 04:44:55 INFO - PROCESS | 2011 | 04:44:55 INFO - PROCESS | 2011 | [#2] jquery.html Cycles:180 Average:40139.89 Median:21782.34 stddev:120128.42 (551.5%) stddev-sans-first:120428.31 04:44:55 INFO - PROCESS | 2011 | Values: 375.9 389.7 393.0 395.4 421.4 17115.7 20283.8 20566.4 21276.6 21297.5 21150.6 21159.5 21162.8 21536.1 21603.2 5699.3 6046.3 6063.9 6066.8 6067.3 5709.3 5832.5 5906.3 5948.6 5952.9 5892.4 5903.9 5909.7 5912.9 5948.1 5640.8 5799.7 5833.2 5881.6 5930.3 5177.6 5181.2 5189.4 5191.4 5218.5 25698.9 25913.6 26045.1 26063.7 26386.3 2657.9 2709.2 2722.8 2750.4 2757.4 15724.8 15966.5 16074.0 16089.8 16572.6 1738.5 1833.8 1834.1 1861.6 1864.8 131069.0 133336.7 134081.0 135433.6 135593.0 9939.7 10997.4 11895.5 11963.7 12147.8 11554.5 14391.0 14725.9 15776.8 15800.4 8352.5 8648.8 8737.7 8764.3 8816.4 8516.7 8527.7 8540.4 8544.4 8696.7 4789.4 4881.8 4894.8 4902.6 4951.3 2031.5 2059.7 2064.8 2065.8 2072.7 1003.8 1005.4 1015.4 1016.1 1055.5 21038.8 21550.9 21564.0 21654.8 21909.9 1024.7 1032.4 1045.8 1055.5 1083.4 10128.0 10868.3 11129.1 11154.1 11183.7 712046.0 712674.4 716053.0 726996.0 731006.0 147972.0 155003.0 155179.0 156256.4 158051.0 983.8 990.9 1009.0 1014.3 1018.2 19020.6 19101.7 19138.3 19185.8 19208.6 57506.4 57971.8 58053.8 58182.1 58216.0 83612.6 84055.0 84163.0 84525.0 85750.6 7259.7 8381.7 8394.7 8677.0 8696.7 10367.3 12930.7 12933.7 12950.2 13346.1 9716.0 9915.1 10880.9 11080.7 11493.0 9609.8 9748.8 11002.5 11162.9 11507.0 11310.7 11597.9 11724.4 11795.5 11897.9 6489.3 8480.2 8533.5 8537.5 8692.1 8469.4 10840.9 11444.1 11451.4 11533.0 04:44:55 INFO - PROCESS | 2011 | 04:44:55 INFO - PROCESS | 2011 | [#3] mootools.html Cycles:180 Average:5413.36 Median:5319.32 stddev:2968.13 (55.8%) stddev-sans-first:2961.45 04:44:55 INFO - PROCESS | 2011 | Values: 1442.4 1479.9 1485.4 1489.2 1503.7 7585.0 7626.7 7826.2 8129.3 8261.1 8076.4 8363.6 8373.5 8474.2 8482.3 2077.1 2299.5 2352.8 2359.0 2366.5 2332.2 2339.9 2374.8 2387.7 2387.8 2313.3 2323.6 2343.1 2343.8 2345.5 2280.9 2303.0 2308.3 2331.7 2339.0 2316.4 2329.7 2347.4 2347.9 2352.4 8377.2 8446.4 8449.5 8459.4 8496.2 5065.1 5234.5 5240.8 5242.1 5247.4 3236.8 3259.4 3461.2 3493.6 3507.3 1107.6 1109.7 1152.0 1157.1 1180.4 10725.2 10763.8 10857.9 10872.8 10890.9 4460.7 4699.9 4732.1 4773.8 4785.4 9406.2 9528.8 9543.0 9549.6 9555.2 4618.5 5253.0 5283.5 5286.3 5309.5 3978.4 4189.7 4734.6 4760.9 4870.4 3376.9 3656.1 3884.4 3910.4 3954.1 1306.8 1310.2 1314.1 1315.0 1333.3 866.7 868.3 879.6 894.7 913.7 5329.1 5338.1 5551.1 5564.0 5601.0 538.0 538.4 553.0 566.1 570.4 3599.4 3659.9 3706.2 3774.3 3805.9 9630.1 9954.2 9966.3 9968.3 9987.6 9877.4 9917.2 9935.2 9946.4 9978.7 7670.4 7736.8 7785.0 7888.5 7963.1 5291.5 5442.0 5496.6 5599.5 5637.0 7596.0 9242.0 9307.8 9339.1 9342.5 9208.4 9424.3 9443.6 9493.6 9516.0 6593.2 6770.2 6951.1 7089.7 7178.5 7782.3 7978.4 8047.0 8050.2 8053.3 7054.6 7141.6 7206.2 7211.9 7277.9 6943.4 7062.3 7096.5 7168.5 7188.0 6239.4 6260.0 6327.9 6328.4 6331.7 4921.1 4964.0 4977.5 4995.1 5040.2 4833.5 4894.9 5006.5 5088.2 5131.7 04:44:55 INFO - PROCESS | 2011 | 04:44:55 INFO - PROCESS | 2011 | [#4] prototype.html Cycles:180 Average:4511.79 Median:5071.24 stddev:1372.59 (27.1%) stddev-sans-first:1339.96 04:44:55 INFO - PROCESS | 2011 | Values: 323.3 346.5 357.1 367.5 372.7 4369.4 5026.5 5090.6 5308.8 5523.9 4554.9 5367.6 5394.2 5435.3 5473.2 3762.6 4021.5 4297.4 4326.2 4328.8 3554.7 3926.5 4226.0 4237.9 4242.6 4060.7 4171.5 4185.7 4199.0 4201.2 3544.6 3603.3 4247.9 4271.6 4275.9 3162.7 3173.9 3194.4 3567.0 3753.5 4431.9 4818.4 5292.3 5359.3 5369.1 4884.5 4903.4 4904.8 4927.8 4930.0 5069.9 5113.3 5114.6 5485.5 5522.0 3335.8 3823.0 3923.6 3935.4 3964.4 5311.3 5320.1 5573.9 6121.7 6183.0 3776.2 3908.0 3941.5 3941.6 4004.6 3318.8 3687.4 3994.8 3998.8 4010.4 3914.4 4411.3 4696.0 4745.5 4755.3 4678.0 5522.6 5556.3 5879.7 5904.9 1091.7 1181.5 1309.2 1318.9 1322.7 768.9 832.8 835.7 845.5 881.5 4316.5 4379.8 4534.2 4547.1 4991.1 5247.8 5278.2 5665.5 5804.0 5960.0 5187.2 5327.9 5389.6 5463.6 5488.2 2493.9 2705.9 2800.7 2953.1 3005.6 5072.5 5610.7 5710.5 5787.5 5990.3 5278.4 5343.3 5658.6 5737.5 5869.0 5125.6 5711.4 5717.7 5858.8 5996.4 5041.7 5205.6 5677.9 5786.4 5804.9 4732.8 5068.7 5174.8 5597.8 5687.6 5352.0 5359.9 5678.7 5886.9 5911.4 3950.0 3991.6 4057.9 4075.4 4090.8 5145.9 5588.8 5612.6 5678.5 5745.4 5184.6 5463.2 5484.6 5497.5 5563.8 4659.7 5020.8 5043.7 5522.8 5538.3 4399.8 5014.3 5115.9 5335.1 5373.4 4475.2 5335.9 5356.4 5399.2 5491.1 5244.7 5410.3 5413.0 5639.7 5724.5 04:44:55 INFO - PROCESS | 2011 | 04:44:55 INFO - PROCESS | 2011 | [#5] yui.html Cycles:180 Average:20011.95 Median:4007.95 stddev:28014.38 (699.0%) stddev-sans-first:28055.52 04:44:55 INFO - PROCESS | 2011 | Values: 720.5 736.8 736.9 776.8 823.5 15418.6 15963.3 16045.5 16105.3 16112.2 14727.0 14901.5 14905.9 14929.8 14957.3 681.1 705.3 856.7 877.2 877.8 841.5 866.3 868.1 869.6 874.6 920.2 925.8 932.9 934.8 936.2 915.1 918.6 925.4 926.0 926.5 687.7 688.2 688.5 689.4 691.1 14748.6 15139.8 15185.2 15417.9 15612.0 14165.9 14466.9 14552.1 14624.9 14634.3 11728.2 11747.5 11748.2 11785.3 11799.9 3679.5 3723.5 3742.3 3771.6 3787.0 83026.6 100491.5 105034.5 106310.5 107115.9 10588.3 10887.6 11101.3 11245.5 11448.8 17977.9 22725.2 23252.0 23252.2 23516.2 7725.3 7727.8 7781.3 7905.8 8014.4 4228.9 4243.7 4293.6 4341.7 4416.3 3539.5 3602.6 3627.7 3636.7 3642.1 499.0 634.7 637.4 650.5 658.2 665.7 690.4 701.8 710.6 728.5 9127.5 9802.2 10348.6 10472.6 10809.1 591.1 650.8 671.5 672.4 701.9 4357.9 4784.8 5047.2 5062.5 5065.6 84505.6 95161.0 98025.0 98296.0 99862.0 91494.0 92042.6 92985.5 95764.0 97213.0 65928.7 68076.0 69349.6 74533.3 75291.9 10443.6 10743.9 10954.5 11046.9 11055.9 48440.8 49611.0 50246.0 50727.5 51638.5 57586.6 58629.0 60869.0 61696.4 64076.0 13078.6 13474.4 13681.7 13683.6 13788.3 14851.6 14918.5 14956.1 15079.5 15574.5 13771.0 13811.7 13939.6 13966.7 14317.6 11504.9 14000.3 14013.1 14283.6 14458.5 13186.5 13369.0 13719.9 13953.4 14141.9 11001.8 11090.6 11106.7 11395.4 11520.4 9688.1 10370.7 11054.2 11332.5 11382.9 04:44:55 INFO - PROCESS | 2011 | -------- Summary: end -------- 04:44:55 INFO - PROCESS | 2011 | 04:44:55 INFO - TEST-INFO | 2011: exit 0 04:44:55 INFO - TEST-OK | dromaeo_css | took 1115096ms 04:44:55 INFO - TEST-START | kraken 04:44:55 INFO - operating with platform_type : mac_ 04:44:55 INFO - Initialising browser for kraken test... 04:44:55 INFO - TEST-INFO | started process 2016 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/tmplY0QkQ/profile http://localhost:49335/getInfo.html) 04:44:58 INFO - PROCESS | 2016 | 2017-01-15 04:44:58.487 plugin-container[2018:15941] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8843, name = 'com.apple.tsm.portname' 04:44:58 INFO - PROCESS | 2016 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:44:58 INFO - PROCESS | 2016 | 2017-01-15 04:44:58.488 plugin-container[2018:15941] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b13, name = 'com.apple.CFPasteboardClient' 04:44:58 INFO - PROCESS | 2016 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:44:58 INFO - PROCESS | 2016 | 2017-01-15 04:44:58.488 plugin-container[2018:15941] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:44:58 INFO - PROCESS | 2016 | __metrics Screen width/height:1600/1200 04:44:58 INFO - PROCESS | 2016 | colorDepth:24 04:44:58 INFO - PROCESS | 2016 | Browser inner width/height: 1024/689 04:44:58 INFO - PROCESS | 2016 | __metrics 04:44:58 ERROR - PROCESS | 2016 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3249: TypeError: this.tabs is undefined 04:44:59 INFO - TEST-INFO | 2016: exit 0 04:44:59 INFO - Browser initialized. 04:44:59 INFO - Running cycle 1/1 for kraken test... 04:44:59 INFO - TEST-INFO | started process 2019 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/tmplY0QkQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:45:01 INFO - PROCESS | 2019 | 2017-01-15 04:45:01.791 plugin-container[2020:16074] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x444b, name = 'com.apple.tsm.portname' 04:45:01 INFO - PROCESS | 2019 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:45:01 INFO - PROCESS | 2019 | 2017-01-15 04:45:01.792 plugin-container[2020:16074] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 04:45:01 INFO - PROCESS | 2019 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:45:01 INFO - PROCESS | 2019 | 2017-01-15 04:45:01.792 plugin-container[2020:16074] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:45:11 INFO - PROCESS | 2019 | RSS: Main: 233201664 04:45:11 INFO - PROCESS | 2019 | 04:45:14 INFO - PROCESS | 2019 | Cycle 1(1): loaded http://localhost:49335/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49335/tests/kraken/driver.html?testName=audio-beat-detection) 04:45:15 INFO - PROCESS | 2019 | RSS: Main: 245944320 04:45:15 INFO - PROCESS | 2019 | 04:45:18 INFO - PROCESS | 2019 | Cycle 1(1): loaded http://localhost:49335/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49335/tests/kraken/driver.html?testName=audio-dft) 04:45:18 INFO - PROCESS | 2019 | RSS: Main: 253964288 04:45:18 INFO - PROCESS | 2019 | 04:45:22 INFO - PROCESS | 2019 | Cycle 1(1): loaded http://localhost:49335/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49335/tests/kraken/driver.html?testName=audio-fft) 04:45:23 INFO - PROCESS | 2019 | RSS: Main: 256700416 04:45:23 INFO - PROCESS | 2019 | 04:45:25 INFO - PROCESS | 2019 | Cycle 1(1): loaded http://localhost:49335/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49335/tests/kraken/driver.html?testName=audio-oscillator) 04:45:25 INFO - PROCESS | 2019 | RSS: Main: 258859008 04:45:25 INFO - PROCESS | 2019 | 04:45:27 INFO - PROCESS | 2019 | Cycle 1(1): loaded http://localhost:49335/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49335/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:45:28 INFO - PROCESS | 2019 | RSS: Main: 259174400 04:45:28 INFO - PROCESS | 2019 | 04:45:31 INFO - PROCESS | 2019 | Cycle 1(1): loaded http://localhost:49335/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49335/tests/kraken/driver.html?testName=imaging-darkroom) 04:45:32 INFO - PROCESS | 2019 | RSS: Main: 264781824 04:45:32 INFO - PROCESS | 2019 | 04:45:35 INFO - PROCESS | 2019 | Cycle 1(1): loaded http://localhost:49335/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49335/tests/kraken/driver.html?testName=imaging-desaturate) 04:45:36 INFO - PROCESS | 2019 | RSS: Main: 264421376 04:45:36 INFO - PROCESS | 2019 | 04:45:39 INFO - PROCESS | 2019 | Cycle 1(1): loaded http://localhost:49335/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49335/tests/kraken/driver.html?testName=json-parse-financial) 04:45:39 INFO - PROCESS | 2019 | RSS: Main: 264425472 04:45:39 INFO - PROCESS | 2019 | 04:45:41 INFO - PROCESS | 2019 | Cycle 1(1): loaded http://localhost:49335/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49335/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:45:42 INFO - PROCESS | 2019 | RSS: Main: 263663616 04:45:42 INFO - PROCESS | 2019 | 04:45:43 INFO - PROCESS | 2019 | Cycle 1(1): loaded http://localhost:49335/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49335/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:45:44 INFO - PROCESS | 2019 | RSS: Main: 263639040 04:45:44 INFO - PROCESS | 2019 | 04:45:46 INFO - PROCESS | 2019 | Cycle 1(1): loaded http://localhost:49335/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49335/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:45:47 INFO - PROCESS | 2019 | RSS: Main: 263733248 04:45:47 INFO - PROCESS | 2019 | 04:45:50 INFO - PROCESS | 2019 | Cycle 1(1): loaded http://localhost:49335/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49335/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:45:51 INFO - PROCESS | 2019 | RSS: Main: 264028160 04:45:51 INFO - PROCESS | 2019 | 04:45:54 INFO - PROCESS | 2019 | Cycle 1(1): loaded http://localhost:49335/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49335/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:45:54 INFO - PROCESS | 2019 | RSS: Main: 263831552 04:45:54 INFO - PROCESS | 2019 | 04:45:56 INFO - PROCESS | 2019 | Cycle 1(1): loaded http://localhost:49335/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49335/tests/kraken/driver.html?testName=ai-astar) 04:45:56 INFO - PROCESS | 2019 | RSS: Main: 267022336 04:45:56 INFO - PROCESS | 2019 | 04:45:56 INFO - PROCESS | 2019 | __start_tp_report 04:45:56 INFO - PROCESS | 2019 | _x_x_mozilla_page_load 04:45:56 INFO - PROCESS | 2019 | _x_x_mozilla_page_load_details 04:45:56 INFO - PROCESS | 2019 | |i|pagename|runs| 04:45:56 INFO - PROCESS | 2019 | |0;ai-astar;106;119;136;159;176;107;102;161;177;177 04:45:56 INFO - PROCESS | 2019 | |1;audio-beat-detection;148;112;114;149;127;104;129;127;151;148 04:45:56 INFO - PROCESS | 2019 | |2;audio-dft;264;192;196;200;197;200;203;196;251;273 04:45:56 INFO - PROCESS | 2019 | |3;audio-fft;86;59;60;87;61;60;60;54;87;58 04:45:56 INFO - PROCESS | 2019 | |4;audio-oscillator;106;100;114;102;64;64;113;101;100;80 04:45:56 INFO - PROCESS | 2019 | |5;imaging-gaussian-blur;103;90;103;128;97;89;94;76;134;129 04:45:56 INFO - PROCESS | 2019 | |6;imaging-darkroom;122;170;168;100;102;100;100;101;124;170 04:45:56 INFO - PROCESS | 2019 | |7;imaging-desaturate;92;96;90;92;99;80;132;152;119;94 04:45:56 INFO - PROCESS | 2019 | |8;json-parse-financial;62;61;62;61;64;63;62;63;63;61 04:45:56 INFO - PROCESS | 2019 | |9;json-stringify-tinderbox;66;78;72;75;69;70;72;72;74;72 04:45:56 INFO - PROCESS | 2019 | |10;stanford-crypto-aes;90;88;79;90;102;108;88;90;82;101 04:45:56 INFO - PROCESS | 2019 | |11;stanford-crypto-ccm;156;156;148;141;140;139;141;152;184;173 04:45:56 INFO - PROCESS | 2019 | |12;stanford-crypto-pbkdf2;175;177;173;177;173;175;174;175;176;176 04:45:56 INFO - PROCESS | 2019 | |13;stanford-crypto-sha256-iterative;68;71;87;89;66;69;80;87;83;85 04:45:56 INFO - PROCESS | 2019 | __end_tp_report 04:45:56 INFO - PROCESS | 2019 | __start_cc_report 04:45:56 INFO - PROCESS | 2019 | _x_x_mozilla_cycle_collect,938 04:45:56 INFO - PROCESS | 2019 | __end_cc_report 04:45:56 INFO - PROCESS | 2019 | __startTimestamp1484484356776__endTimestamp 04:45:56 INFO - PROCESS | 2019 | 04:45:56 INFO - PROCESS | 2019 | ------- Summary: start ------- 04:45:56 INFO - PROCESS | 2019 | Number of tests: 14 04:45:56 INFO - PROCESS | 2019 | 04:45:56 INFO - PROCESS | 2019 | [#0] ai-astar Cycles:10 Average:142.00 Median:160.00 stddev:31.52 (19.7%) stddev-sans-first:30.62 04:45:56 INFO - PROCESS | 2019 | Values: 106.0 119.0 136.0 159.0 176.0 107.0 102.0 161.0 177.0 177.0 04:45:56 INFO - PROCESS | 2019 | 04:45:56 INFO - PROCESS | 2019 | [#1] audio-beat-detection Cycles:10 Average:130.90 Median:138.50 stddev:17.37 (12.5%) stddev-sans-first:17.29 04:45:56 INFO - PROCESS | 2019 | Values: 148.0 112.0 114.0 149.0 127.0 104.0 129.0 127.0 151.0 148.0 04:45:56 INFO - PROCESS | 2019 | 04:45:56 INFO - PROCESS | 2019 | [#2] audio-dft Cycles:10 Average:217.20 Median:201.50 stddev:31.94 (15.9%) stddev-sans-first:29.04 04:45:56 INFO - PROCESS | 2019 | Values: 264.0 192.0 196.0 200.0 197.0 200.0 203.0 196.0 251.0 273.0 04:45:56 INFO - PROCESS | 2019 | 04:45:56 INFO - PROCESS | 2019 | [#3] audio-fft Cycles:10 Average:67.20 Median:60.50 stddev:13.57 (22.4%) stddev-sans-first:12.57 04:45:56 INFO - PROCESS | 2019 | Values: 86.0 59.0 60.0 87.0 61.0 60.0 60.0 54.0 87.0 58.0 04:45:56 INFO - PROCESS | 2019 | 04:45:56 INFO - PROCESS | 2019 | [#4] audio-oscillator Cycles:10 Average:94.40 Median:113.50 stddev:18.51 (16.3%) stddev-sans-first:19.15 04:45:56 INFO - PROCESS | 2019 | Values: 106.0 100.0 114.0 102.0 64.0 64.0 113.0 101.0 100.0 80.0 04:45:56 INFO - PROCESS | 2019 | 04:45:56 INFO - PROCESS | 2019 | [#5] imaging-gaussian-blur Cycles:10 Average:104.30 Median:82.50 stddev:19.60 (23.8%) stddev-sans-first:20.78 04:45:56 INFO - PROCESS | 2019 | Values: 103.0 90.0 103.0 128.0 97.0 89.0 94.0 76.0 134.0 129.0 04:45:56 INFO - PROCESS | 2019 | 04:45:56 INFO - PROCESS | 2019 | [#6] imaging-darkroom Cycles:10 Average:125.70 Median:123.00 stddev:31.42 (25.5%) stddev-sans-first:33.30 04:45:56 INFO - PROCESS | 2019 | Values: 122.0 170.0 168.0 100.0 102.0 100.0 100.0 101.0 124.0 170.0 04:45:56 INFO - PROCESS | 2019 | 04:45:56 INFO - PROCESS | 2019 | [#7] imaging-desaturate Cycles:10 Average:104.60 Median:92.00 stddev:22.51 (24.5%) stddev-sans-first:23.40 04:45:56 INFO - PROCESS | 2019 | Values: 92.0 96.0 90.0 92.0 99.0 80.0 132.0 152.0 119.0 94.0 04:45:56 INFO - PROCESS | 2019 | 04:45:56 INFO - PROCESS | 2019 | [#8] json-parse-financial Cycles:10 Average:62.20 Median:62.50 stddev:1.03 (1.7%) stddev-sans-first:1.09 04:45:56 INFO - PROCESS | 2019 | Values: 62.0 61.0 62.0 61.0 64.0 63.0 62.0 63.0 63.0 61.0 04:45:56 INFO - PROCESS | 2019 | 04:45:56 INFO - PROCESS | 2019 | [#9] json-stringify-tinderbox Cycles:10 Average:72.00 Median:72.00 stddev:3.30 (4.6%) stddev-sans-first:2.69 04:45:56 INFO - PROCESS | 2019 | Values: 66.0 78.0 72.0 75.0 69.0 70.0 72.0 72.0 74.0 72.0 04:45:56 INFO - PROCESS | 2019 | 04:45:56 INFO - PROCESS | 2019 | [#10] stanford-crypto-aes Cycles:10 Average:91.80 Median:88.00 stddev:9.13 (10.4%) stddev-sans-first:9.66 04:45:56 INFO - PROCESS | 2019 | Values: 90.0 88.0 79.0 90.0 102.0 108.0 88.0 90.0 82.0 101.0 04:45:56 INFO - PROCESS | 2019 | 04:45:56 INFO - PROCESS | 2019 | [#11] stanford-crypto-ccm Cycles:10 Average:153.00 Median:154.00 stddev:15.12 (9.8%) stddev-sans-first:16.00 04:45:56 INFO - PROCESS | 2019 | Values: 156.0 156.0 148.0 141.0 140.0 139.0 141.0 152.0 184.0 173.0 04:45:56 INFO - PROCESS | 2019 | 04:45:56 INFO - PROCESS | 2019 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.10 Median:175.50 stddev:1.45 (0.8%) stddev-sans-first:1.54 04:45:56 INFO - PROCESS | 2019 | Values: 175.0 177.0 173.0 177.0 173.0 175.0 174.0 175.0 176.0 176.0 04:45:56 INFO - PROCESS | 2019 | 04:45:56 INFO - PROCESS | 2019 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.50 Median:84.00 stddev:9.02 (10.7%) stddev-sans-first:8.73 04:45:56 INFO - PROCESS | 2019 | Values: 68.0 71.0 87.0 89.0 66.0 69.0 80.0 87.0 83.0 85.0 04:45:56 INFO - PROCESS | 2019 | -------- Summary: end -------- 04:45:56 INFO - PROCESS | 2019 | 04:45:57 INFO - TEST-INFO | 2019: exit 0 04:45:57 INFO - TEST-OK | kraken | took 61790ms 04:45:57 INFO - SUITE-END | took 1176s 04:45:57 INFO - Completed test suite (00:19:37) 04:45:57 INFO - javascript benchmark 04:45:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7307.453556518487, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3269.8855540056097, 3328.8668453261885, 3379.2396710740086, 3382.560267165268, 3392.304577561599, 5632.295963004624, 5758.4529469700365, 5760.04959181735, 5764.971175144124, 5827.883442331162, 4518.796654150563, 5641.435856414367, 5769.682667453289, 5810.070388737803, 5888.617239879415, 5225.817096401626, 5239.056969745444, 5281.207818827168, 5282.683039017671, 5298.523132918037, 5279.9208011879855, 5338.492843179892, 5350.30446042014, 5378.973105134469, 5381.784728610851, 5327.813526526592, 5343.171808369709, 5348.304720386363, 5353.84860843813, 5423.0, 5149.0216858797085, 5154.433012368637, 5203.557697595709, 5208.635395522315, 5251.186066159751, 5145.716985565792, 5163.509466600667, 5211.0, 5242.81650142247, 5259.815906443256, 4227.556106608792, 5605.215269862222, 5682.9486544988895, 5740.856478588069, 5770.04794208955, 6107.856436553706, 6126.724297406583, 6133.82435864808, 6148.6618235997, 6166.691665416712, 5144.974275128638, 6122.947104152868, 6196.0, 6200.379962003809, 6204.348543402923, 5921.052631578927, 5921.111833225008, 5926.140709597084, 5937.614055086406, 5945.078512830518, 5979.53501392153, 6089.0, 6287.937120628827, 6302.086197501337, 6319.747210111636, 5396.9730151348995, 6084.269887613426, 6115.143879856823, 6124.197855633957, 6130.092410195535, 6138.296437970408, 6242.250929888442, 6242.282137554149, 6250.0, 6253.874922501615, 6134.00801433197, 6135.110179431455, 6136.447719705158, 6137.4995631051315, 6157.907631385533, 6144.801763656044, 6161.84595385119, 6190.81427557174, 6192.504599632019, 6198.442140207403, 4948.38145231846, 4981.875453113701, 5059.468755780664, 5083.924225843385, 5124.718140502308, 4446.911061778746, 4519.028408892104, 4519.163954668397, 4538.773061346919, 4550.726956382628, 4511.98480341927, 5691.459311365414, 5716.228309178207, 5906.734196961147, 5948.256467941507, 5423.3491980962535, 6231.9094158522985, 6236.126942228092, 6247.718852651642, 6256.593321434092, 4879.926801097987, 5676.574256930747, 5852.824415267549, 5854.677992710442, 5884.7940322088525, 4590.770461476913, 5426.864328391822, 5484.314460692413, 5500.3949565547755, 5531.446855314517, 6398.168238129199, 6440.581362211441, 6455.225372955276, 6459.224893012869, 6491.350864913471, 6264.467520260647, 6273.466755325666, 6276.748930042747, 6288.213973253343, 6300.2754683212015, 6199.752009919553, 6201.007838745779, 6246.281677606951, 6460.418562329413, 6504.772332968323, 6128.0, 6172.9505983981935, 6184.474319682698, 6194.101855230876, 6197.752089916353, 6226.221722284715, 6231.2522497300615, 6237.03325984455, 6238.750449982132, 6269.529785266032, 4727.456342520654, 5925.200097986889, 5979.730912109053, 6054.939450605438, 6055.727492262947, 6071.423214794588, 6075.088736689532, 6102.7619317136805, 6171.105189747372, 6171.6297022178815, 5927.940720592739, 5934.109883517507, 6024.578279520391, 6084.421979911901, 6084.660046828098, 6059.242594675666, 6068.089786531879, 6102.549845102896, 6119.051547010221, 6136.355682653257, 6068.51451883857, 6073.058675905242, 6077.179580756541, 6104.4505994460715, 6119.510439164767], "value": 5682.088345520801, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [455.6059008957251, 465.3159855013129, 474.9977547375038, 482.83583581582275, 487.37615851709813, 32847.67152328476, 39676.60323396765, 41905.371419428695, 42209.57790422095, 42243.15513689724, 42554.787226063905, 43066.0, 43574.56425435745, 43635.47275845346, 43769.12461750763, 7597.620118994028, 7830.804229894241, 8572.14278572144, 9092.22716069135, 9345.2991025673, 10370.429626370547, 10749.731256718567, 11144.498497567629, 11426.028787553068, 11633.476493557768, 10491.895081049168, 10653.573857045709, 11355.0, 11404.087672986141, 11442.542298308057, 9626.181774549172, 11386.772264554746, 11488.310701357945, 11490.36802975836, 11493.482793274323, 11085.113190944705, 11138.554457821678, 11293.458971731377, 11376.715582110432, 11408.885911140866, 40817.591824081675, 40983.38524922128, 41169.58830411688, 41208.96977575555, 41293.380599291035, 4030.375291829771, 4066.1664358806374, 4133.565975572552, 4151.792410379499, 4226.492820861486, 25353.61969570458, 29661.110166694816, 31450.0, 31679.366412671618, 31752.523712144335, 3113.315070684446, 3145.528170774402, 3158.1630867820045, 3161.7944833585975, 3163.225009872573, 440921.0, 445723.0, 487396.0, 489162.55418723036, 490951.0, 62537.0, 62962.37037629657, 63146.36853631405, 63171.368286316545, 63270.683646582394, 58894.70552647295, 63556.41108972313, 65720.34279657142, 66369.33630663728, 66839.66580167068, 13198.934005330104, 16322.428714995156, 16346.75479867803, 16372.345106195618, 16381.672366552602, 11125.276857004268, 11394.715132121763, 12197.878021219674, 12315.0, 12638.368081596067, 16848.820582559103, 17920.28318867257, 19012.61974760497, 19032.904835476013, 19075.90462047681, 5961.910571341434, 6928.792136235921, 6971.163460384786, 7085.751998680022, 7086.574805511686, 870.5995242188537, 890.0387581412059, 890.2966656341547, 892.3441270666056, 929.1776777551916, 24146.0, 29369.7063029367, 30388.240293992385, 30600.54099188514, 30904.845475772476, 1057.3867157048894, 1057.5241141486208, 1096.155959910864, 1110.816715241976, 1195.9521619135137, 15643.0, 15647.295871685801, 15828.76256856148, 16218.270177842025, 16398.934069285457, 610598.4170870645, 865393.0, 878414.0, 879406.0, 879719.2028079637, 53945.0, 54544.72727636337, 54566.72716636471, 54573.45426545763, 54627.907441851734, 1424.5370254667275, 1430.9069910455787, 1460.547230358571, 1464.4508309384194, 1468.8249400479574, 29005.564916525847, 29030.41939161247, 29101.0, 29451.558226627047, 29649.0, 47283.763581181876, 47625.76187119042, 47644.76177619228, 47654.52345476501, 47814.043719124726, 434993.0, 465387.0, 545396.0, 546333.2683336717, 546369.0, 20126.09432575567, 24449.144279950116, 24988.50022999566, 25028.62457063182, 25331.873340633916, 33208.1697957553, 42291.154176915676, 43118.35322470103, 43871.12257754891, 45523.77238113788, 35951.64048359483, 35962.0, 36292.0, 36925.44611830771, 37190.628093719795, 35398.29203415969, 36356.727514537924, 36466.63533364632, 36878.0, 37124.25751485009, 35266.11834704153, 35267.0, 35633.57465701447, 35859.282814344086, 36161.45757813582, 30940.0, 32153.678463216005, 32177.0, 32259.70961161527, 32374.83812580922, 24249.87875060684, 24359.75640243646, 24414.87792561097, 24719.887605058175, 24906.87546562328], "value": 19918.9313860879, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.8778397020968, 389.6940901392406, 393.0, 395.4384773621457, 421.42054674822117, 17115.74326385105, 20283.797162028393, 20566.383008509732, 21276.574468510622, 21297.467563310925, 21150.57698846026, 21159.471013224676, 21162.788372116273, 21536.13855445784, 21603.243886463977, 5699.344575373833, 6046.304674962392, 6063.878722425548, 6066.817995460143, 6067.332593414721, 5709.286339207599, 5832.475077243047, 5906.26171728534, 5948.583599148062, 5952.88094238115, 5892.410758924095, 5903.940960590382, 5909.704514774266, 5912.940870591304, 5948.107783832416, 5640.830775076754, 5799.710014499279, 5833.183354330397, 5881.558883083786, 5930.318013428447, 5177.58579313654, 5181.171012637998, 5189.377274727057, 5191.428942816287, 5218.478152184789, 25698.871505642353, 25913.61129583058, 26045.088421905333, 26063.73936260651, 26386.340341491425, 2657.946841063187, 2709.2143278449225, 2722.7821774258014, 2750.35366688828, 2757.352022274764, 15724.842751572452, 15966.521004369888, 16073.955192912423, 16089.839101609068, 16572.58568535784, 1738.4697667211497, 1833.7982821889582, 1834.110456428631, 1861.6183682345086, 1864.8041955594604, 131069.0, 133336.66663333436, 134081.0, 135433.64566354308, 135592.999999999, 9939.701808945743, 10997.395143267036, 11895.464704088337, 11963.700907477209, 12147.817782733266, 11554.480048397842, 14391.0, 14725.926370368079, 15776.76334854978, 15800.36798528069, 8352.540610266493, 8648.783780405414, 8737.650493980169, 8764.255038321815, 8816.382853200343, 8516.74449766508, 8527.658893644184, 8540.40217184791, 8544.444611100258, 8696.695615653422, 4789.353437285991, 4881.780319885614, 4894.828680996148, 4902.583280421133, 4951.331570238044, 2031.4515080928068, 2059.7013433052125, 2064.834813214939, 2065.83926592311, 2072.668373060303, 1003.8393856982848, 1005.4419797012728, 1015.3552494166257, 1016.1261315268863, 1055.5302890213934, 21038.78961210399, 21550.892245538984, 21564.0, 21654.783452165593, 21909.890450547646, 1024.6721049264313, 1032.442481060219, 1045.7856139491387, 1055.5091882274778, 1083.4366129612558, 10128.0, 10868.347899126078, 11129.054030407344, 11154.051905587954, 11183.72040698989, 712046.0, 712674.4366278135, 716053.0, 726996.0, 731006.0, 147972.0, 155003.0, 155179.0, 156256.43743562646, 158051.0, 983.7934033852828, 990.8761404824397, 1009.0414106598761, 1014.3356101753216, 1018.2057994764095, 19020.619587607893, 19101.713474298176, 19138.330158444387, 19185.808141918962, 19208.615827683647, 57506.42493575011, 57971.84056318934, 58053.83892322046, 58182.127268091856, 58216.0, 83612.58193708993, 84055.0, 84163.0, 84525.0, 85750.57124714337, 7259.676903390864, 8381.664733410595, 8394.706185283485, 8676.956615216883, 8696.739097827076, 10367.27429079957, 12930.741385172432, 12933.676658083623, 12950.222986620833, 13346.13250138738, 9716.028397160228, 9915.058069483388, 10880.945595271973, 11080.670319561705, 11493.0, 9609.807803843743, 9748.756281092747, 11002.50488727993, 11162.939520745516, 11507.021903137993, 11310.660680179608, 11597.88402115968, 11724.355160466257, 11795.469203885674, 11897.94051029774, 6489.253735820441, 8480.15198480147, 8533.487990720576, 8537.53043582584, 8692.130786921258, 8469.407141500036, 10840.891591083988, 11444.141689373164, 11451.427428628702, 11533.015704257097], "value": 10036.778026652159, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1442.3941944383357, 1479.8816094712417, 1485.420685932486, 1489.2181604657553, 1503.654159543305, 7585.013948186742, 7626.733064342756, 7826.217378262171, 8129.309008734257, 8261.132581078982, 8076.434649574532, 8363.623636936338, 8373.539455329954, 8474.194951479614, 8482.321414286858, 2077.1379877350882, 2299.4596269876565, 2352.8235382346393, 2358.988205058981, 2366.5030343627773, 2332.1604222479896, 2339.8713070781187, 2374.750651181627, 2387.7254115776736, 2387.844790088647, 2313.3406979010983, 2323.6049871521795, 2343.1330407749156, 2343.824213184018, 2345.5074434368803, 2280.931572052833, 2302.9539409211807, 2308.3305841306, 2331.661909023182, 2339.0059224829465, 2316.3514216019544, 2329.650552417134, 2347.3779448446176, 2347.929562113139, 2352.388379021467, 8377.246047855722, 8446.408751387406, 8449.493030418194, 8459.365547583895, 8496.150384961516, 5065.138926382524, 5234.476552344773, 5240.842774716764, 5242.135047717122, 5247.39654939683, 3236.838158092086, 3259.3970115528464, 3461.2039230977016, 3493.580770307554, 3507.333606614735, 1107.5514416661265, 1109.6948339206701, 1151.9596814111467, 1157.1437136519, 1180.3685028509706, 10725.195610329178, 10763.784724305548, 10857.945710271399, 10872.782544349147, 10890.891091089066, 4460.710053846489, 4699.929501057487, 4732.0772449372735, 4773.761311934459, 4785.449673287547, 9406.153446189739, 9528.761780955532, 9542.950275469693, 9549.61801527945, 9555.23558115349, 4618.468876079227, 5252.9737351313, 5283.471652834763, 5286.286351342519, 5309.495597918191, 3978.4430179774854, 4189.706720529594, 4734.573888350065, 4760.928586071212, 4870.366852309248, 3376.898693039213, 3656.104254457675, 3884.397918322608, 3910.413437984325, 3954.051027753376, 1306.8497122830806, 1310.1614966421498, 1314.1392387985884, 1315.0, 1333.300017490825, 866.7096522664978, 868.2880038368603, 879.6349514951223, 894.735282789681, 913.7350168451075, 5329.147336426231, 5338.145896656516, 5551.111822108524, 5564.026295398289, 5601.019821531216, 537.9919301210485, 538.4104405675779, 552.9723513824292, 566.0688167963676, 570.3697414357158, 3599.352116618981, 3659.890203293852, 3706.184639379332, 3774.2640185164178, 3805.9429108563395, 9630.133288004114, 9954.153896918699, 9966.2525310602, 9968.302218844756, 9987.550560224807, 9877.357971731815, 9917.206623470105, 9935.205183585296, 9946.403215807075, 9978.700638980843, 7670.4247181461615, 7736.7678969631, 7784.9610751945875, 7888.487248328955, 7963.084245311863, 5291.523762861361, 5441.972790136024, 5496.615236933376, 5599.496045355774, 5637.041702910433, 7596.0, 9242.0, 9307.76730581741, 9339.112784285482, 9342.486163261086, 9208.447493150432, 9424.340296179202, 9443.575039123118, 9493.572789224363, 9515.952420237854, 6593.208814942238, 6770.1537307836525, 6951.123196736751, 7089.680964356513, 7178.461615378763, 7782.260685234894, 7978.361731061385, 8046.959765201136, 8050.154733753106, 8053.31546818527, 7054.611996340251, 7141.571505709674, 7206.243344448757, 7211.927880721336, 7277.9272207277245, 6943.409810166192, 7062.258462861326, 7096.467764917755, 7168.498205125591, 7188.0, 6239.438450539473, 6259.96870015647, 6327.90508142369, 6328.398802113792, 6331.683415829282, 4921.114199444134, 4964.032013757283, 4977.502249775139, 4995.075910956485, 5040.193569028937, 4833.468318485035, 4894.92657610129, 5006.4743201963265, 5088.244555628302, 5131.717755523482], "value": 4351.883500018169, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.3016683962643, 346.4750902382889, 357.1001077285241, 367.470841987538, 372.6571554170163, 4369.438907290556, 5026.522480364369, 5090.592752579794, 5308.787648494061, 5523.861903452415, 4554.931676024862, 5367.645221736415, 5394.244805727191, 5435.2934118564535, 5473.233747275384, 3762.5673047599466, 4021.4517410796907, 4297.419848320484, 4326.221280169569, 4328.783560821947, 3554.6800787929083, 3926.5288165420047, 4225.978870105645, 4237.894052648693, 4242.575742425748, 4060.7157498975084, 4171.4994200695955, 4185.74885506869, 4199.0, 4201.243776120297, 3544.5923718772415, 3603.3153700796765, 4247.851325203618, 4271.572842715735, 4275.850345237902, 3162.7153556180056, 3173.8571764270664, 3194.3611277744544, 3567.0061913321297, 3753.4932784074344, 4431.889202769924, 4818.421789385261, 5292.259083728281, 5359.303290572239, 5369.114096174127, 4884.4871288514905, 4903.411590609114, 4904.803807847682, 4927.7536123193695, 4929.975350123263, 5069.944044764174, 5113.335266415379, 5114.565261952701, 5485.506304432581, 5522.012075652762, 3335.8332083395735, 3823.044238940265, 3923.6272554107313, 3935.4490371347747, 3964.365701487748, 5311.336082989626, 5320.127131349067, 5573.857359241386, 6121.693915304217, 6182.96908515459, 3776.2258736958856, 3908.0, 3941.467901833273, 3941.586133455946, 4004.6184066497012, 3318.7510936679846, 3687.391580389206, 3994.840206391712, 3998.8400463981698, 4010.3984402339884, 3914.4324073009825, 4411.316245981878, 4695.95304046962, 4745.525447455227, 4755.310479980383, 4678.0, 5522.641028333226, 5556.333240011225, 5879.735411906475, 5904.881902362014, 1091.7434402915308, 1181.497863408048, 1309.2079292028377, 1318.8747069028427, 1322.735452909422, 768.8846672999094, 832.8417600655856, 835.7409203147043, 845.5330002445752, 881.457903389411, 4316.525182229952, 4379.781010949439, 4534.183846907522, 4547.136044151601, 4991.057064918746, 5247.842564723064, 5278.155495120763, 5665.490105890407, 5804.026630945415, 5959.986802243629, 5187.247849061865, 5327.866803329948, 5389.568834493231, 5463.617546771768, 5488.231647569343, 2493.90024399022, 2705.891764329405, 2800.6639203295736, 2953.0697830183854, 3005.5792189093545, 5072.54347108762, 5610.747516361692, 5710.486056254957, 5787.5080618147085, 5990.251218597676, 5278.445763194886, 5343.251944727741, 5658.603897727202, 5737.512311453574, 5868.972929737364, 5125.564327032244, 5711.371749107595, 5717.739075712088, 5858.765649374062, 5996.370381110008, 5041.706023759108, 5205.58355331565, 5677.858053548694, 5786.363500015079, 5804.941950580609, 4732.834350797705, 5068.746562671926, 5174.844754657366, 5597.832065038056, 5687.578105473632, 5352.0, 5359.946400536101, 5678.744456499385, 5886.852828679317, 5911.408859114054, 3950.024987506247, 3991.5808840071372, 4057.8812505306546, 4075.3683179107284, 4090.795460227036, 5145.92281115776, 5588.804391846266, 5612.579056570692, 5678.517326027334, 5745.425457454221, 5184.5781784022365, 5463.159157238134, 5484.643498172606, 5497.505224529811, 5563.805266815642, 4659.65052621048, 5020.824271150492, 5043.747812609428, 5522.779088836402, 5538.335399752055, 4399.846005389924, 5014.348134742606, 5115.900081482499, 5335.146376579729, 5373.382061063028, 4475.172093162775, 5335.866603334947, 5356.384015838073, 5399.163129714901, 5491.066518691752, 5244.685318880879, 5410.269613602113, 5413.0, 5639.689817060101, 5724.454397312619], "value": 4079.832308533841, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [720.4812534974819, 736.8342123022318, 736.9336759691629, 776.7708525984834, 823.460633285198, 15418.61453463664, 15963.328434460082, 16045.518634440956, 16105.27526261321, 16112.194390280498, 14727.0, 14901.478448254313, 14905.92547037266, 14929.776053359208, 14957.252137393141, 681.1077488490081, 705.3087973785667, 856.6530555125153, 877.1666916429385, 877.784942689042, 841.5287439034161, 866.2723312417568, 868.1275318305126, 869.5826003518315, 874.5802015032788, 920.2316066084827, 925.842606756853, 932.883389576303, 934.7522906429801, 936.2229349639782, 915.0712027292337, 918.6004088221578, 925.3799954030782, 925.9768505787342, 926.5413620257948, 687.669918439152, 688.1948120698794, 688.5455599304435, 689.4208864553799, 691.1257259566652, 14748.631284217872, 15139.772903406458, 15185.240737963057, 15417.922910385489, 15612.0, 14165.858341416557, 14466.92766536171, 14552.126872387691, 14624.853751462455, 14634.268286585628, 11728.237664551776, 11747.47136378865, 11748.236364636357, 11785.292882427082, 11799.94100029503, 3679.5400574928135, 3723.4600982857605, 3742.3450896093345, 3771.6039815819217, 3787.0343062519155, 83026.58486707589, 100491.49754251182, 105034.47482762537, 106310.46844765804, 107115.92884071215, 10588.311759735592, 10887.564497420015, 11101.333919964827, 11245.493952772145, 11448.828267575993, 17977.910110449364, 22725.204617838295, 23251.953662085245, 23252.186173484184, 23516.176933807234, 7725.266099720518, 7727.845443091219, 7781.288116614336, 7905.762827115196, 8014.358851291882, 4228.873133805991, 4243.68172387066, 4293.570642935744, 4341.696081274281, 4416.271315232951, 3539.5398598182073, 3602.603713591503, 3627.673509384168, 3636.7454278200803, 3642.053066202753, 498.9700617962934, 634.7238951056305, 637.353086617084, 650.5478692308894, 658.203573675848, 665.6571865489277, 690.3648643248224, 701.7614011236102, 710.5985118408083, 728.4791374167389, 9127.452352858716, 9802.166815820592, 10348.637797677045, 10472.581096756197, 10809.135269178447, 591.0985746736176, 650.8275307043542, 671.5461026876854, 672.4351544702473, 701.8806802843427, 4357.869263922087, 4784.832530861473, 5047.217681259411, 5062.519060689228, 5065.569426598707, 84505.57747211224, 95161.04838951521, 98025.0, 98296.0, 99862.0, 91494.0, 92042.61936070964, 92985.5350723242, 95764.0, 97213.0, 65928.67035664887, 68076.0, 69349.61300773956, 74533.25466745372, 75291.87062194181, 10443.634472793416, 10743.946280268548, 10954.507047182737, 11046.898428113163, 11055.944720276348, 48440.75779621079, 49611.0, 50246.0, 50727.49272507375, 51638.483615163364, 57586.56033599193, 58629.0, 60869.0, 61696.38303617086, 64076.0, 13078.607641770763, 13474.393652285475, 13681.657958551115, 13683.589492315246, 13788.310584470937, 14851.554453366416, 14918.477853275517, 14956.116783091493, 15079.54761357161, 15574.532764017098, 13771.0, 13811.654708632364, 13939.581812545639, 13966.720665586834, 14317.57047288583, 11504.884951150381, 14000.299985000913, 14013.089149205269, 14283.64290892736, 14458.493952711604, 13186.472541098248, 13369.0, 13719.862801371859, 13953.372098255806, 14141.858581414053, 11001.779964400826, 11090.5563777448, 11106.722331941766, 11395.430228488376, 11520.366379849189, 9688.12806847387, 10370.688879333633, 11054.170937179582, 11332.490037948477, 11382.886171138514], "value": 7548.48493674189, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1618.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 119.0, 136.0, 159.0, 176.0, 107.0, 102.0, 161.0, 177.0, 177.0], "value": 142.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 112.0, 114.0, 149.0, 127.0, 104.0, 129.0, 127.0, 151.0, 148.0], "value": 130.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [264.0, 192.0, 196.0, 200.0, 197.0, 200.0, 203.0, 196.0, 251.0, 273.0], "value": 217.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 59.0, 60.0, 87.0, 61.0, 60.0, 60.0, 54.0, 87.0, 58.0], "value": 67.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 100.0, 114.0, 102.0, 64.0, 64.0, 113.0, 101.0, 100.0, 80.0], "value": 94.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 90.0, 103.0, 128.0, 97.0, 89.0, 94.0, 76.0, 134.0, 129.0], "value": 104.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 170.0, 168.0, 100.0, 102.0, 100.0, 100.0, 101.0, 124.0, 170.0], "value": 125.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 96.0, 90.0, 92.0, 99.0, 80.0, 132.0, 152.0, 119.0, 94.0], "value": 104.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 62.0, 61.0, 64.0, 63.0, 62.0, 63.0, 63.0, 61.0], "value": 62.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 78.0, 72.0, 75.0, 69.0, 70.0, 72.0, 72.0, 74.0, 72.0], "value": 72.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 88.0, 79.0, 90.0, 102.0, 108.0, 88.0, 90.0, 82.0, 101.0], "value": 91.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 156.0, 148.0, 141.0, 140.0, 139.0, 141.0, 152.0, 184.0, 173.0], "value": 153.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 177.0, 173.0, 177.0, 173.0, 175.0, 174.0, 175.0, 176.0, 176.0], "value": 175.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 71.0, 87.0, 89.0, 66.0, 69.0, 80.0, 87.0, 83.0, 85.0], "value": 78.5, "unit": "score"}]}]} 04:45:57 INFO - Return code: 0 04:45:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:45:58 ERROR - # TBPL SUCCESS # 04:45:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:45:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:45:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:45:58 INFO - 2017-01-15 04:45:58.050 screenresolution[2026:16505] starting screenresolution argv=screenresolution get 04:45:58 INFO - 2017-01-15 04:45:58.054 screenresolution[2026:16505] Display 0: 1600x1200x32@60 04:45:58 INFO - 2017-01-15 04:45:58.060 screenresolution[2027:16508] starting screenresolution argv=screenresolution list 04:45:58 INFO - Available Modes on Display 0 04:45:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:45:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:45:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:45:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:45:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:45:58 INFO - Intel Iris: 04:45:58 INFO - Chipset Model: Intel Iris 04:45:58 INFO - Type: GPU 04:45:58 INFO - Bus: Built-In 04:45:58 INFO - VRAM (Dynamic, Max): 1536 MB 04:45:58 INFO - Vendor: Intel (0x8086) 04:45:58 INFO - Device ID: 0x0a2e 04:45:58 INFO - Revision ID: 0x0009 04:45:58 INFO - Displays: 04:45:58 INFO - Display: 04:45:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:45:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:45:58 INFO - Display Serial Number: 1600x1200 60 04:45:58 INFO - Main Display: Yes 04:45:58 INFO - Mirror: Off 04:45:58 INFO - Online: Yes 04:45:58 INFO - Rotation: Supported 04:45:58 INFO - Return code: 0 04:45:58 INFO - Running post-action listener: _resource_record_post_action 04:45:58 INFO - [mozharness: 2017-01-15 12:45:58.301630Z] Finished run-tests step (success) 04:45:58 INFO - Running post-run listener: _resource_record_post_run 04:45:58 INFO - Total resource usage - Wall time: 1200s; CPU: 55.0%; Read bytes: 524288; Write bytes: 557950464; Read time: 10; Write time: 1728 04:45:58 INFO - TinderboxPrint: CPU usage
54.6% 04:45:58 INFO - TinderboxPrint: I/O read bytes / time
524,288 / 10 04:45:58 INFO - TinderboxPrint: I/O write bytes / time
557,950,464 / 1,728 04:45:58 INFO - TinderboxPrint: CPU idle
2,178.9 (45.4%) 04:45:58 INFO - TinderboxPrint: CPU system
973.4 (20.3%) 04:45:58 INFO - TinderboxPrint: CPU user
1,649.5 (34.4%) 04:45:58 INFO - TinderboxPrint: Swap in / out
251,273,216 / 0 04:45:58 INFO - install - Wall time: 23s; CPU: 55.0%; Read bytes: 239071744; Write bytes: 231653376; Read time: 17516; Write time: 509 04:45:58 INFO - run-tests - Wall time: 1178s; CPU: 55.0%; Read bytes: 516096; Write bytes: 302559232; Read time: 9; Write time: 1156 04:45:58 INFO - Running post-run listener: _upload_blobber_files 04:45:58 INFO - Blob upload gear active. 04:45:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:45:58 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 04:45:58 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'] 04:45:58 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 04:45:59 INFO - (blobuploader) - INFO - Open directory for files ... 04:45:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:45:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:45:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:46:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:46:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:46:00 INFO - (blobuploader) - INFO - Done attempting. 04:46:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:46:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:46:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:46:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:46:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:46:01 INFO - (blobuploader) - INFO - Done attempting. 04:46:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:46:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:46:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:46:02 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:46:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:46:02 INFO - (blobuploader) - INFO - Done attempting. 04:46:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:46:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:46:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:46:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:46:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:46:04 INFO - (blobuploader) - INFO - Done attempting. 04:46:04 INFO - (blobuploader) - INFO - Iteration through files over. 04:46:04 INFO - Return code: 0 04:46:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:46:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:46:04 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2a87d00e27f641e7daa2e8b50e8b75e52cc27ab46708fcff845cf5a0b4827e359f8e0724657bca3b194b755f142103911fa3dc802208fed73de37428e4ecc167", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2acf361caa40cac5c37a15f54285dc84292fe3c3e7a48e69f249a0ddb28e5d925384c93fec803cb00489ab3d3e3521fd7da2339b2e87a4c69cb248f799cc3be3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0bef476d526d31f2c73e82a46bd28b959488d5a64fb61c0a85ce1e69667d9d3c3fab3da7817d81f46329e691593021fb7e49b3d226caf6d4d8391f0132c42e9d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3184ee0bbfd97b18a921b6240d26d2916c92d27b4758e1da13bda4b748ca82c64bc5565629235ca462c2eda9b63a6af33918832bb3a5f3046eab173bf6e9e4b8"} 04:46:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:46:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:46:04 INFO - Contents: 04:46:04 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2a87d00e27f641e7daa2e8b50e8b75e52cc27ab46708fcff845cf5a0b4827e359f8e0724657bca3b194b755f142103911fa3dc802208fed73de37428e4ecc167", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2acf361caa40cac5c37a15f54285dc84292fe3c3e7a48e69f249a0ddb28e5d925384c93fec803cb00489ab3d3e3521fd7da2339b2e87a4c69cb248f799cc3be3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0bef476d526d31f2c73e82a46bd28b959488d5a64fb61c0a85ce1e69667d9d3c3fab3da7817d81f46329e691593021fb7e49b3d226caf6d4d8391f0132c42e9d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3184ee0bbfd97b18a921b6240d26d2916c92d27b4758e1da13bda4b748ca82c64bc5565629235ca462c2eda9b63a6af33918832bb3a5f3046eab173bf6e9e4b8"} 04:46:04 INFO - Running post-run listener: copy_logs_to_upload_dir 04:46:04 INFO - Copying logs to upload dir... 04:46:04 INFO - mkdir: /builds/slave/test/build/upload/logs 04:46:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.118874 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-01-15 04:46:04.562637) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-15 04:46:04.565781) ========= 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.pco38WBinJ/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.pgb5FQgZm4/Listeners TMPDIR=/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/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/2a87d00e27f641e7daa2e8b50e8b75e52cc27ab46708fcff845cf5a0b4827e359f8e0724657bca3b194b755f142103911fa3dc802208fed73de37428e4ecc167", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2acf361caa40cac5c37a15f54285dc84292fe3c3e7a48e69f249a0ddb28e5d925384c93fec803cb00489ab3d3e3521fd7da2339b2e87a4c69cb248f799cc3be3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0bef476d526d31f2c73e82a46bd28b959488d5a64fb61c0a85ce1e69667d9d3c3fab3da7817d81f46329e691593021fb7e49b3d226caf6d4d8391f0132c42e9d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3184ee0bbfd97b18a921b6240d26d2916c92d27b4758e1da13bda4b748ca82c64bc5565629235ca462c2eda9b63a6af33918832bb3a5f3046eab173bf6e9e4b8"} build_url:https://queue.taskcluster.net/v1/task/IyJWPtNKTZ-8r6FAqikyLA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011174 build_url: 'https://queue.taskcluster.net/v1/task/IyJWPtNKTZ-8r6FAqikyLA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2a87d00e27f641e7daa2e8b50e8b75e52cc27ab46708fcff845cf5a0b4827e359f8e0724657bca3b194b755f142103911fa3dc802208fed73de37428e4ecc167", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2acf361caa40cac5c37a15f54285dc84292fe3c3e7a48e69f249a0ddb28e5d925384c93fec803cb00489ab3d3e3521fd7da2339b2e87a4c69cb248f799cc3be3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0bef476d526d31f2c73e82a46bd28b959488d5a64fb61c0a85ce1e69667d9d3c3fab3da7817d81f46329e691593021fb7e49b3d226caf6d4d8391f0132c42e9d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3184ee0bbfd97b18a921b6240d26d2916c92d27b4758e1da13bda4b748ca82c64bc5565629235ca462c2eda9b63a6af33918832bb3a5f3046eab173bf6e9e4b8"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-15 04:46:04.604862) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-15 04:46:04.605681) ========= 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.pco38WBinJ/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.pgb5FQgZm4/Listeners TMPDIR=/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/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.005305 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-15 04:46:04.655911) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-15 04:46:04.656204) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-15 04:46:04.656507) ========= ========= Total master_lag: 0.20 =========