builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0321 starttime: 1484137561.72 results: success (0) buildid: 20170111030235 builduid: d52c1d1c1f2144a4a0e0a5a459aa8f19 revision: 2963cf6be7f830c0d2155e2968cfc53585868a76 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-11 04:26:01.723542) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-11 04:26:01.724295) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-11 04:26:01.724764) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-11 04:26:01.753119) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-11 04:26:01.753455) ========= 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.AnjsRo7lbg/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.37BrffcNBB/Listeners TMPDIR=/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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-11 04:26:01-- 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% 18.2M=0.001s 2017-01-11 04:26:01 (18.2 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.109549 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-11 04:26:01.888696) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-11 04:26:01.889032) ========= 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.AnjsRo7lbg/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.37BrffcNBB/Listeners TMPDIR=/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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.025392 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-11 04:26:01.938518) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-11 04:26:01.938931) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 2963cf6be7f830c0d2155e2968cfc53585868a76 --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 2963cf6be7f830c0d2155e2968cfc53585868a76 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.AnjsRo7lbg/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.37BrffcNBB/Listeners TMPDIR=/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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-11 04:26:02,052 truncating revision to first 12 chars 2017-01-11 04:26:02,052 Setting DEBUG logging. 2017-01-11 04:26:02,052 attempt 1/10 2017-01-11 04:26:02,052 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/2963cf6be7f8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-11 04:26:02,746 unpacking tar archive at: mozilla-central-2963cf6be7f8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.965177 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-11 04:26:02.929041) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-11 04:26:02.929414) ========= script_repo_revision: 2963cf6be7f830c0d2155e2968cfc53585868a76 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-11 04:26:02.929870) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-11 04:26:02.930193) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-11 04:26:02.950493) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-01-11 04:26:02.950957) ========= /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.AnjsRo7lbg/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.37BrffcNBB/Listeners TMPDIR=/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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:26:03 INFO - MultiFileLogger online at 20170111 04:26:03 in /builds/slave/test 04:26:03 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:26:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:26:03 INFO - {'append_to_log': False, 04:26:03 INFO - 'base_work_dir': '/builds/slave/test', 04:26:03 INFO - 'blob_upload_branch': 'Firefox', 04:26:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:26:03 INFO - 'branch': 'Firefox', 04:26:03 INFO - 'buildbot_json_path': 'buildprops.json', 04:26:03 INFO - 'config_files': ('talos/mac_config.py',), 04:26:03 INFO - 'default_actions': ('clobber', 04:26:03 INFO - 'read-buildbot-config', 04:26:03 INFO - 'download-and-extract', 04:26:03 INFO - 'populate-webroot', 04:26:03 INFO - 'create-virtualenv', 04:26:03 INFO - 'install', 04:26:03 INFO - 'run-tests'), 04:26:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:26:03 INFO - 'download_minidump_stackwalk': True, 04:26:03 INFO - 'download_symbols': 'ondemand', 04:26:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:26:03 INFO - 'tooltool.py': '/tools/tooltool.py', 04:26:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:26:03 INFO - '/tools/misc-python/virtualenv.py')}, 04:26:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:26:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:26:03 INFO - 'installer_path': 'installer.exe', 04:26:03 INFO - 'log_level': 'info', 04:26:03 INFO - 'log_name': 'talos', 04:26:03 INFO - 'log_to_console': True, 04:26:03 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:26:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:26:03 INFO - 'opt_config_files': (), 04:26:03 INFO - 'pip_index': False, 04:26:03 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:26:03 INFO - 'cmd': ('bash', 04:26:03 INFO - '-c', 04:26:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:26:03 INFO - 'enabled': True, 04:26:03 INFO - 'halt_on_failure': False, 04:26:03 INFO - 'name': 'check_screen_resolution'},), 04:26:03 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:26:03 INFO - 'cmd': ('bash', 04:26:03 INFO - '-c', 04:26:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:26:03 INFO - 'enabled': True, 04:26:03 INFO - 'halt_on_failure': False, 04:26:03 INFO - 'name': 'check_screen_resolution'},), 04:26:03 INFO - 'run_cmd_checks_enabled': True, 04:26:03 INFO - 'sps_profile': False, 04:26:03 INFO - 'sps_profile_interval': 0, 04:26:03 INFO - 'suite': 'dromaeojs-e10s', 04:26:03 INFO - 'system_bits': '32', 04:26:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:26:03 INFO - 'title': 't-yosemite-r7-0321', 04:26:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:26:03 INFO - 'use_talos_json': True, 04:26:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:26:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:26:03 INFO - 'work_dir': 'build'} 04:26:03 INFO - [mozharness: 2017-01-11 12:26:03.170448Z] Running clobber step. 04:26:03 INFO - Running pre-action listener: _resource_record_pre_action 04:26:03 INFO - Running main action method: clobber 04:26:03 INFO - rmtree: /builds/slave/test/build 04:26:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:26:05 INFO - Running post-action listener: _resource_record_post_action 04:26:05 INFO - [mozharness: 2017-01-11 12:26:05.520018Z] Finished clobber step (success) 04:26:05 INFO - [mozharness: 2017-01-11 12:26:05.520183Z] Running read-buildbot-config step. 04:26:05 INFO - Running pre-action listener: _resource_record_pre_action 04:26:05 INFO - Running main action method: read_buildbot_config 04:26:05 INFO - Using buildbot properties: 04:26:05 INFO - { 04:26:05 INFO - "project": "", 04:26:05 INFO - "product": "firefox", 04:26:05 INFO - "script_repo_revision": "production", 04:26:05 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 04:26:05 INFO - "repository": "", 04:26:05 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 04:26:05 INFO - "buildid": "20170111030235", 04:26:05 INFO - "stage_platform": "macosx64", 04:26:05 INFO - "basedir": "/builds/slave/test", 04:26:05 INFO - "nightly_build": "True", 04:26:05 INFO - "buildnumber": 34, 04:26:05 INFO - "slavename": "t-yosemite-r7-0321", 04:26:05 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 04:26:05 INFO - "platform": "yosemite_r7", 04:26:05 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:26:05 INFO - "branch": "mozilla-central", 04:26:05 INFO - "repo_path": "mozilla-central", 04:26:05 INFO - "revision": "2963cf6be7f830c0d2155e2968cfc53585868a76", 04:26:05 INFO - "pgo_build": "False", 04:26:05 INFO - "builduid": "d52c1d1c1f2144a4a0e0a5a459aa8f19", 04:26:05 INFO - "slavebuilddir": "test" 04:26:05 INFO - } 04:26:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/KPQ0m4W3TPioLGtFx4ChlA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 04:26:05 INFO - Running post-action listener: _resource_record_post_action 04:26:05 INFO - [mozharness: 2017-01-11 12:26:05.523689Z] Finished read-buildbot-config step (success) 04:26:05 INFO - [mozharness: 2017-01-11 12:26:05.523800Z] Running download-and-extract step. 04:26:05 INFO - Running pre-action listener: _resource_record_pre_action 04:26:05 INFO - Running main action method: download_and_extract 04:26:05 INFO - mkdir: /builds/slave/test/build/tests 04:26:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:26:05 INFO - trying https://queue.taskcluster.net/v1/task/KPQ0m4W3TPioLGtFx4ChlA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 04:26:05 INFO - Downloading https://queue.taskcluster.net/v1/task/KPQ0m4W3TPioLGtFx4ChlA/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:26:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KPQ0m4W3TPioLGtFx4ChlA/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:26:06 INFO - Downloaded 1199 bytes. 04:26:06 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 04:26:06 INFO - Using the following test package requirements: 04:26:06 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 04:26:06 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:26:06 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 04:26:06 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:26:06 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 04:26:06 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:26:06 INFO - u'jsshell-mac.zip'], 04:26:06 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:26:06 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 04:26:06 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 04:26:06 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:26:06 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 04:26:06 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:26:06 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 04:26:06 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:26:06 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 04:26:06 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:26:06 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 04:26:06 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:26:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KPQ0m4W3TPioLGtFx4ChlA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 04:26:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KPQ0m4W3TPioLGtFx4ChlA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:26:06 INFO - Fetch https://queue.taskcluster.net/v1/task/KPQ0m4W3TPioLGtFx4ChlA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 04:26:07 INFO - Expected file size: 16311445 04:26:07 INFO - Obtained file size: 16311445 04:26:14 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:26:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KPQ0m4W3TPioLGtFx4ChlA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 04:26:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KPQ0m4W3TPioLGtFx4ChlA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:26:14 INFO - Fetch https://queue.taskcluster.net/v1/task/KPQ0m4W3TPioLGtFx4ChlA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 04:26:15 INFO - Expected file size: 16311445 04:26:15 INFO - Obtained file size: 16311445 04:26:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KPQ0m4W3TPioLGtFx4ChlA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 04:26:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KPQ0m4W3TPioLGtFx4ChlA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:26:21 INFO - Fetch https://queue.taskcluster.net/v1/task/KPQ0m4W3TPioLGtFx4ChlA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 04:26:22 INFO - Expected file size: 14403529 04:26:22 INFO - Obtained file size: 14403529 04:26:23 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:23 INFO - trying https://queue.taskcluster.net/v1/task/KPQ0m4W3TPioLGtFx4ChlA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 04:26:23 INFO - Downloading https://queue.taskcluster.net/v1/task/KPQ0m4W3TPioLGtFx4ChlA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 04:26:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KPQ0m4W3TPioLGtFx4ChlA/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:26:24 INFO - Downloaded 69904724 bytes. 04:26:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KPQ0m4W3TPioLGtFx4ChlA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 04:26:24 INFO - mkdir: /builds/slave/test/properties 04:26:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:26:24 INFO - Writing to file /builds/slave/test/properties/build_url 04:26:24 INFO - Contents: 04:26:24 INFO - build_url:https://queue.taskcluster.net/v1/task/KPQ0m4W3TPioLGtFx4ChlA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 04:26:26 INFO - Running post-action listener: _resource_record_post_action 04:26:26 INFO - Running post-action listener: set_extra_try_arguments 04:26:26 INFO - [mozharness: 2017-01-11 12:26:26.100760Z] Finished download-and-extract step (success) 04:26:26 INFO - [mozharness: 2017-01-11 12:26:26.100883Z] Running populate-webroot step. 04:26:26 INFO - Running pre-action listener: _resource_record_pre_action 04:26:26 INFO - Running main action method: populate_webroot 04:26:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:26:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:26:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:26:26 INFO - '--tppagecycles', 04:26:26 INFO - '7'], 04:26:26 INFO - 'tests': ['tsvgm']}}, 04:26:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:26:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:26:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:26:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:26:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:26:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:26:26 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:26:26 INFO - 'talos_options': ['--disable-e10s'], 04:26:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:26:26 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:26:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:26:26 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:26:26 INFO - 'talos_options': ['--disable-e10s'], 04:26:26 INFO - 'tests': ['damp', 'tps']}, 04:26:26 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:26:26 INFO - 'tests': ['damp', 'tps']}, 04:26:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:26:26 INFO - 'tests': ['dromaeo_dom']}, 04:26:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:26:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:26:26 INFO - 'tests': ['basic_compositor_video']}, 04:26:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:26:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:26:26 INFO - 'tests': ['a11yr', 04:26:26 INFO - 'ts_paint', 04:26:26 INFO - 'tpaint', 04:26:26 INFO - 'sessionrestore', 04:26:26 INFO - 'sessionrestore_no_auto_restore', 04:26:26 INFO - 'tabpaint']}, 04:26:26 INFO - 'other-e10s': {'tests': ['a11yr', 04:26:26 INFO - 'ts_paint', 04:26:26 INFO - 'tpaint', 04:26:26 INFO - 'sessionrestore', 04:26:26 INFO - 'sessionrestore_no_auto_restore', 04:26:26 INFO - 'tabpaint']}, 04:26:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:26:26 INFO - 'ts_paint', 04:26:26 INFO - 'tpaint', 04:26:26 INFO - 'sessionrestore', 04:26:26 INFO - 'sessionrestore_no_auto_restore', 04:26:26 INFO - 'tabpaint']}, 04:26:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:26:26 INFO - 'ts_paint', 04:26:26 INFO - 'tpaint', 04:26:26 INFO - 'sessionrestore', 04:26:26 INFO - 'sessionrestore_no_auto_restore', 04:26:26 INFO - 'tabpaint']}, 04:26:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:26:26 INFO - 'tests': ['a11yr', 04:26:26 INFO - 'ts_paint', 04:26:26 INFO - 'tpaint', 04:26:26 INFO - 'sessionrestore', 04:26:26 INFO - 'sessionrestore_no_auto_restore', 04:26:26 INFO - 'tabpaint']}, 04:26:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:26:26 INFO - 'tests': ['a11yr', 04:26:26 INFO - 'ts_paint', 04:26:26 INFO - 'tpaint', 04:26:26 INFO - 'sessionrestore', 04:26:26 INFO - 'sessionrestore_no_auto_restore', 04:26:26 INFO - 'tabpaint']}, 04:26:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:26:26 INFO - 'tests': ['tsvgx', 04:26:26 INFO - 'tsvgr_opacity', 04:26:26 INFO - 'tart', 04:26:26 INFO - 'tscrollx', 04:26:26 INFO - 'cart', 04:26:26 INFO - 'tsvg_static']}, 04:26:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:26:26 INFO - 'tsvgr_opacity', 04:26:26 INFO - 'tart', 04:26:26 INFO - 'tscrollx', 04:26:26 INFO - 'cart', 04:26:26 INFO - 'tsvg_static']}, 04:26:26 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:26:26 INFO - 'talos_options': ['--disable-e10s'], 04:26:26 INFO - 'tests': ['tp5o']}, 04:26:26 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:26:26 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:26:26 INFO - 'talos_options': ['--disable-e10s', 04:26:26 INFO - '--xperf_path', 04:26:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:26:26 INFO - 'tests': ['tp5n']}, 04:26:26 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:26:26 INFO - 'talos_options': ['--xperf_path', 04:26:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:26:26 INFO - 'tests': ['tp5n']}}, 04:26:26 INFO - 'talos.zip': {'path': '', 04:26:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:26:26 INFO - Running post-action listener: _resource_record_post_action 04:26:26 INFO - [mozharness: 2017-01-11 12:26:26.119892Z] Finished populate-webroot step (success) 04:26:26 INFO - [mozharness: 2017-01-11 12:26:26.120026Z] Running create-virtualenv step. 04:26:26 INFO - Running pre-action listener: _resource_record_pre_action 04:26:26 INFO - Running main action method: create_virtualenv 04:26:26 INFO - Creating virtualenv /builds/slave/test/build/venv 04:26:26 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:26:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:26:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:26:26 INFO - Using real prefix '/tools/python27' 04:26:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:26:26 INFO - Installing distribute.............................................................................................................................................................................................done. 04:26:29 INFO - Installing pip.................done. 04:26:29 INFO - Return code: 0 04:26:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:26:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:26:30 INFO - Reading from file tmpfile_stdout 04:26:30 INFO - Output received: 04:26:30 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:26:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:26:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:26:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:26:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:30 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 0x10527fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105282768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9381c6f090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10505dd30>, '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 0x104f84db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105052be8>, '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.AnjsRo7lbg/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.37BrffcNBB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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:26:30 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:26:30 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:26:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AnjsRo7lbg/Render', 04:26:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:26:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:26:30 INFO - 'HOME': '/Users/cltbld', 04:26:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:26:30 INFO - 'LOGNAME': 'cltbld', 04:26:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:30 INFO - 'MOZ_NO_REMOTE': '1', 04:26:30 INFO - 'NO_EM_RESTART': '1', 04:26:30 INFO - 'PAGER': '/bin/cat', 04:26:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:26:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:30 INFO - 'PWD': '/builds/slave/test', 04:26:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:26:30 INFO - 'SHELL': '/bin/bash', 04:26:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.37BrffcNBB/Listeners', 04:26:30 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 04:26:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:26:30 INFO - 'USER': 'cltbld', 04:26:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:26:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:26:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:30 INFO - 'XPC_FLAGS': '0x0', 04:26:30 INFO - 'XPC_SERVICE_NAME': '0', 04:26:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:26:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:30 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:26:30 INFO - Cleaning up... 04:26:30 INFO - Return code: 0 04:26:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:26:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:26:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:26:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:30 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 0x10527fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105282768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9381c6f090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10505dd30>, '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 0x104f84db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105052be8>, '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.AnjsRo7lbg/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.37BrffcNBB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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:26:30 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:26:30 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:26:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AnjsRo7lbg/Render', 04:26:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:26:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:26:30 INFO - 'HOME': '/Users/cltbld', 04:26:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:26:30 INFO - 'LOGNAME': 'cltbld', 04:26:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:30 INFO - 'MOZ_NO_REMOTE': '1', 04:26:30 INFO - 'NO_EM_RESTART': '1', 04:26:30 INFO - 'PAGER': '/bin/cat', 04:26:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:26:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:30 INFO - 'PWD': '/builds/slave/test', 04:26:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:26:30 INFO - 'SHELL': '/bin/bash', 04:26:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.37BrffcNBB/Listeners', 04:26:30 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 04:26:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:26:30 INFO - 'USER': 'cltbld', 04:26:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:26:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:26:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:30 INFO - 'XPC_FLAGS': '0x0', 04:26:30 INFO - 'XPC_SERVICE_NAME': '0', 04:26:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:26:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:30 INFO - Downloading/unpacking psutil>=3.1.1 04:26:30 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:26:30 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:26:30 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:26:30 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:26:30 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:26:30 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:26:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:26:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:26:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:26:34 INFO - Installing collected packages: psutil 04:26:34 INFO - Running setup.py install for psutil 04:26:34 INFO - building 'psutil._psutil_osx' extension 04:26: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_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:26:35 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:26:35 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:26:35 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:26:35 INFO - building 'psutil._psutil_posix' extension 04:26:35 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:26:35 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:26:35 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:26:35 INFO - ^ 04:26:35 INFO - 1 warning generated. 04:26:35 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:26:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:26:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:26:35 INFO - Successfully installed psutil 04:26:35 INFO - Cleaning up... 04:26:35 INFO - Return code: 0 04:26:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:26:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:26:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:26:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:35 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 0x10527fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105282768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9381c6f090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10505dd30>, '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 0x104f84db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105052be8>, '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.AnjsRo7lbg/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.37BrffcNBB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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:26:35 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:26:35 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:26:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AnjsRo7lbg/Render', 04:26:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:26:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:26:35 INFO - 'HOME': '/Users/cltbld', 04:26:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:26:35 INFO - 'LOGNAME': 'cltbld', 04:26:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:35 INFO - 'MOZ_NO_REMOTE': '1', 04:26:35 INFO - 'NO_EM_RESTART': '1', 04:26:35 INFO - 'PAGER': '/bin/cat', 04:26:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:26:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:35 INFO - 'PWD': '/builds/slave/test', 04:26:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:26:35 INFO - 'SHELL': '/bin/bash', 04:26:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.37BrffcNBB/Listeners', 04:26:35 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 04:26:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:26:35 INFO - 'USER': 'cltbld', 04:26:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:26:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:26:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:35 INFO - 'XPC_FLAGS': '0x0', 04:26:35 INFO - 'XPC_SERVICE_NAME': '0', 04:26:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:26:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:26:35 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:26:35 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:26:35 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:26:35 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:26:35 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:26:35 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:26:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:26:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:26:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:26:38 INFO - Installing collected packages: mozsystemmonitor 04:26:38 INFO - Running setup.py install for mozsystemmonitor 04:26:38 INFO - Successfully installed mozsystemmonitor 04:26:38 INFO - Cleaning up... 04:26:38 INFO - Return code: 0 04:26:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:26:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:26:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:26:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:38 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 0x10527fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105282768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9381c6f090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10505dd30>, '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 0x104f84db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105052be8>, '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.AnjsRo7lbg/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.37BrffcNBB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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:26:38 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:26:38 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:26:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AnjsRo7lbg/Render', 04:26:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:26:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:26:38 INFO - 'HOME': '/Users/cltbld', 04:26:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:26:38 INFO - 'LOGNAME': 'cltbld', 04:26:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:38 INFO - 'MOZ_NO_REMOTE': '1', 04:26:38 INFO - 'NO_EM_RESTART': '1', 04:26:38 INFO - 'PAGER': '/bin/cat', 04:26:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:26:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:38 INFO - 'PWD': '/builds/slave/test', 04:26:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:26:38 INFO - 'SHELL': '/bin/bash', 04:26:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.37BrffcNBB/Listeners', 04:26:38 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 04:26:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:26:38 INFO - 'USER': 'cltbld', 04:26:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:26:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:26:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:38 INFO - 'XPC_FLAGS': '0x0', 04:26:38 INFO - 'XPC_SERVICE_NAME': '0', 04:26:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:26:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:39 INFO - Downloading/unpacking jsonschema==2.5.1 04:26:39 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:26:39 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:26:39 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:26:39 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:26:39 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:26:39 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:26:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:26:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:26:41 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:26:41 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:26:41 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:26:41 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:26:41 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:26:41 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:26:42 INFO - Downloading functools32-3.2.3-2.tar.gz 04:26:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:26:42 INFO - warning: no files found matching '*.txt' 04:26:42 INFO - no previously-included directories found matching 'build' 04:26:42 INFO - no previously-included directories found matching 'dist' 04:26:42 INFO - no previously-included directories found matching '.git*' 04:26:42 INFO - Installing collected packages: jsonschema, functools32 04:26:42 INFO - Running setup.py install for functools32 04:26:42 INFO - warning: no files found matching '*.txt' 04:26:42 INFO - no previously-included directories found matching 'build' 04:26:42 INFO - no previously-included directories found matching 'dist' 04:26:42 INFO - no previously-included directories found matching '.git*' 04:26:42 INFO - Successfully installed jsonschema functools32 04:26:42 INFO - Cleaning up... 04:26:42 INFO - Return code: 0 04:26:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:26:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:26:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:26:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10527fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105282768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9381c6f090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10505dd30>, '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 0x104f84db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105052be8>, '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.AnjsRo7lbg/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.37BrffcNBB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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:26:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:26:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:26:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AnjsRo7lbg/Render', 04:26:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:26:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:26:42 INFO - 'HOME': '/Users/cltbld', 04:26:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:26:42 INFO - 'LOGNAME': 'cltbld', 04:26:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:42 INFO - 'MOZ_NO_REMOTE': '1', 04:26:42 INFO - 'NO_EM_RESTART': '1', 04:26:42 INFO - 'PAGER': '/bin/cat', 04:26:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:26:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:42 INFO - 'PWD': '/builds/slave/test', 04:26:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:26:42 INFO - 'SHELL': '/bin/bash', 04:26:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.37BrffcNBB/Listeners', 04:26:42 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 04:26:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:26:42 INFO - 'USER': 'cltbld', 04:26:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:26:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:26:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:42 INFO - 'XPC_FLAGS': '0x0', 04:26:42 INFO - 'XPC_SERVICE_NAME': '0', 04:26:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:26:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:26:42 INFO - Cleaning up... 04:26:42 INFO - Return code: 0 04:26:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:26:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:26:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:26:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10527fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105282768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9381c6f090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10505dd30>, '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 0x104f84db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105052be8>, '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.AnjsRo7lbg/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.37BrffcNBB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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:26:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:26:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:26:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AnjsRo7lbg/Render', 04:26:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:26:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:26:42 INFO - 'HOME': '/Users/cltbld', 04:26:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:26:42 INFO - 'LOGNAME': 'cltbld', 04:26:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:42 INFO - 'MOZ_NO_REMOTE': '1', 04:26:42 INFO - 'NO_EM_RESTART': '1', 04:26:42 INFO - 'PAGER': '/bin/cat', 04:26:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:26:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:42 INFO - 'PWD': '/builds/slave/test', 04:26:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:26:42 INFO - 'SHELL': '/bin/bash', 04:26:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.37BrffcNBB/Listeners', 04:26:42 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 04:26:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:26:42 INFO - 'USER': 'cltbld', 04:26:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:26:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:26:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:42 INFO - 'XPC_FLAGS': '0x0', 04:26:42 INFO - 'XPC_SERVICE_NAME': '0', 04:26:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:26:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:43 INFO - Downloading/unpacking blobuploader==1.2.4 04:26:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:26:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:26:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:26:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:26:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:26:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:26:45 INFO - Downloading blobuploader-1.2.4.tar.gz 04:26:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:26:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:26: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:26: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:26: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:26: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:26: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:26: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:26:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:26:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:26:46 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:26:46 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:26:46 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:26:46 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:26:46 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:26:46 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:26:47 INFO - Downloading docopt-0.6.1.tar.gz 04:26:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:26:47 INFO - Installing collected packages: blobuploader, requests, docopt 04:26:47 INFO - Running setup.py install for blobuploader 04:26:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:26:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:26:47 INFO - Running setup.py install for requests 04:26:47 INFO - Running setup.py install for docopt 04:26:47 INFO - Successfully installed blobuploader requests docopt 04:26:47 INFO - Cleaning up... 04:26:48 INFO - Return code: 0 04:26:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:26:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:26:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:26:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:48 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 0x10527fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105282768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9381c6f090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10505dd30>, '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 0x104f84db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105052be8>, '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.AnjsRo7lbg/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.37BrffcNBB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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:26:48 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:26:48 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:26:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AnjsRo7lbg/Render', 04:26:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:26:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:26:48 INFO - 'HOME': '/Users/cltbld', 04:26:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:26:48 INFO - 'LOGNAME': 'cltbld', 04:26:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:48 INFO - 'MOZ_NO_REMOTE': '1', 04:26:48 INFO - 'NO_EM_RESTART': '1', 04:26:48 INFO - 'PAGER': '/bin/cat', 04:26:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:26:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:48 INFO - 'PWD': '/builds/slave/test', 04:26:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:26:48 INFO - 'SHELL': '/bin/bash', 04:26:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.37BrffcNBB/Listeners', 04:26:48 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 04:26:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:26:48 INFO - 'USER': 'cltbld', 04:26:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:26:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:26:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:48 INFO - 'XPC_FLAGS': '0x0', 04:26:48 INFO - 'XPC_SERVICE_NAME': '0', 04:26:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:26:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:26:48 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-mffZ2T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:26:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:26:48 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-VnYW7u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:26:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:26:48 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-lslylL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:26:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:26:48 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-yGGmGk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:26:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:26:48 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-U4UVf5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:26:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:26:48 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-cJUzsY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:26:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:26:48 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-Wg29bz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:26:49 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-XqzAiL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:26:49 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-kuZYiT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:26:49 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-UDo09s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:26:49 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-4RoNzE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:26:49 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-W8oH3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:26:49 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-5TBXqk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:26:49 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-xGxfr4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:26:49 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-itqY0U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:26:49 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-DaDrPF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:26:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:26:49 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-fFe2Zl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:26:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:26:50 INFO - Running setup.py install for manifestparser 04:26:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:26:50 INFO - Running setup.py install for mozcrash 04:26:50 INFO - Running setup.py install for mozdebug 04:26:50 INFO - Running setup.py install for mozdevice 04:26:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:26:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:26:50 INFO - Running setup.py install for mozfile 04:26:50 INFO - Running setup.py install for mozhttpd 04:26:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:26:50 INFO - Running setup.py install for mozinfo 04:26:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:26:51 INFO - Running setup.py install for mozInstall 04:26:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:26:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:26:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:26:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:26:51 INFO - Running setup.py install for mozleak 04:26:51 INFO - Running setup.py install for mozlog 04:26:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:26:51 INFO - Running setup.py install for moznetwork 04:26:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:26:51 INFO - Running setup.py install for mozprocess 04:26:51 INFO - Running setup.py install for mozprofile 04:26:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:26:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:26:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:26:52 INFO - Running setup.py install for mozrunner 04:26:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:26:52 INFO - Running setup.py install for mozscreenshot 04:26:52 INFO - Running setup.py install for moztest 04:26:52 INFO - Running setup.py install for mozversion 04:26:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:26:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:26:52 INFO - Cleaning up... 04:26:52 INFO - Return code: 0 04:26:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:26:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:26:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:26:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:52 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 0x10527fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105282768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9381c6f090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10505dd30>, '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 0x104f84db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105052be8>, '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.AnjsRo7lbg/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.37BrffcNBB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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:26:52 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:26:52 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:26:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AnjsRo7lbg/Render', 04:26:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:26:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:26:52 INFO - 'HOME': '/Users/cltbld', 04:26:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:26:52 INFO - 'LOGNAME': 'cltbld', 04:26:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:52 INFO - 'MOZ_NO_REMOTE': '1', 04:26:52 INFO - 'NO_EM_RESTART': '1', 04:26:52 INFO - 'PAGER': '/bin/cat', 04:26:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:26:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:52 INFO - 'PWD': '/builds/slave/test', 04:26:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:26:52 INFO - 'SHELL': '/bin/bash', 04:26:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.37BrffcNBB/Listeners', 04:26:52 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 04:26:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:26:52 INFO - 'USER': 'cltbld', 04:26:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:26:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:26:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:52 INFO - 'XPC_FLAGS': '0x0', 04:26:52 INFO - 'XPC_SERVICE_NAME': '0', 04:26:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:26:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:26:52 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-42jsb2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:26:53 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:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:26:53 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-Y8DTrK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:26:53 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:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:26:53 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-qRakw4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:26:53 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:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:26:53 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-DQR5gr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:26:53 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:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:26:53 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-dux9xW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:26:53 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:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:26:53 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-clznLK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:26:53 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:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:26:53 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-Rf6Xag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:26:53 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:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:26:53 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-83I7Ry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:26:53 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:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:26:53 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-b5jQ7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:26:53 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:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:26:53 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-7ON28Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:26:53 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:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:26:53 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-PgzD2X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:26:54 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:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:26:54 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-W76a3G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:26:54 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:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:26:54 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-KwoaK2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:26:54 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:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:26:54 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-cC8SpY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:26:54 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:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:26:54 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-oYC7gi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:26:54 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:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:26:54 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-OIhd6G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:26:54 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:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:26:54 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-iQovbQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:26:54 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:26:54 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:26:54 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:26:54 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:26:54 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:26:54 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:26:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:26:54 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:26:54 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:26:54 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:26:54 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:26:54 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:26:54 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:26:57 INFO - Downloading blessings-1.6.tar.gz 04:26:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:26:57 INFO - Installing collected packages: blessings 04:26:57 INFO - Running setup.py install for blessings 04:26:57 INFO - Successfully installed blessings 04:26:57 INFO - Cleaning up... 04:26:57 INFO - Return code: 0 04:26:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:26:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:26:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:26:57 INFO - Reading from file tmpfile_stdout 04:26:57 INFO - Current package versions: 04:26:57 INFO - blessings == 1.6 04:26:57 INFO - blobuploader == 1.2.4 04:26:57 INFO - docopt == 0.6.1 04:26:57 INFO - functools32 == 3.2.3-2 04:26:57 INFO - jsonschema == 2.5.1 04:26:57 INFO - manifestparser == 1.1 04:26:57 INFO - mozInstall == 1.12 04:26:57 INFO - mozcrash == 1.0 04:26:57 INFO - mozdebug == 0.1 04:26:57 INFO - mozdevice == 0.49 04:26:57 INFO - mozfile == 1.2 04:26:57 INFO - mozhttpd == 0.7 04:26:57 INFO - mozinfo == 0.9 04:26:57 INFO - mozleak == 0.1 04:26:57 INFO - mozlog == 3.4 04:26:57 INFO - moznetwork == 0.27 04:26:57 INFO - mozprocess == 0.24 04:26:57 INFO - mozprofile == 0.28 04:26:57 INFO - mozrunner == 6.13 04:26:57 INFO - mozscreenshot == 0.1 04:26:57 INFO - mozsystemmonitor == 0.3 04:26:57 INFO - moztest == 0.8 04:26:57 INFO - mozversion == 1.4 04:26:57 INFO - psutil == 3.1.1 04:26:57 INFO - requests == 1.2.3 04:26:57 INFO - wsgiref == 0.1.2 04:26:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:26: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:26:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26: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:26:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:57 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 0x10527fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105282768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9381c6f090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10505dd30>, '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 0x104f84db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105052be8>, '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.AnjsRo7lbg/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.37BrffcNBB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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:26:57 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:26:57 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:26:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AnjsRo7lbg/Render', 04:26:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:26:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:26:57 INFO - 'HOME': '/Users/cltbld', 04:26:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:26:57 INFO - 'LOGNAME': 'cltbld', 04:26:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:57 INFO - 'MOZ_NO_REMOTE': '1', 04:26:57 INFO - 'NO_EM_RESTART': '1', 04:26:57 INFO - 'PAGER': '/bin/cat', 04:26:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:26:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:57 INFO - 'PWD': '/builds/slave/test', 04:26:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:26:57 INFO - 'SHELL': '/bin/bash', 04:26:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.37BrffcNBB/Listeners', 04:26:57 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 04:26:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:26:57 INFO - 'USER': 'cltbld', 04:26:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:26:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:26:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:57 INFO - 'XPC_FLAGS': '0x0', 04:26:57 INFO - 'XPC_SERVICE_NAME': '0', 04:26:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:26:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:58 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:26:58 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:26:58 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:26:58 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:26:58 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:26:58 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:26:58 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:26:58 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:26:58 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:26:58 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:26:58 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:26:58 INFO - Cleaning up... 04:26:58 INFO - Return code: 0 04:26:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:26:58 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:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:58 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:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:58 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 0x10527fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105282768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9381c6f090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10505dd30>, '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 0x104f84db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105052be8>, '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.AnjsRo7lbg/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.37BrffcNBB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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:26:58 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:26:58 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:26:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AnjsRo7lbg/Render', 04:26:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:26:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:26:58 INFO - 'HOME': '/Users/cltbld', 04:26:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:26:58 INFO - 'LOGNAME': 'cltbld', 04:26:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:58 INFO - 'MOZ_NO_REMOTE': '1', 04:26:58 INFO - 'NO_EM_RESTART': '1', 04:26:58 INFO - 'PAGER': '/bin/cat', 04:26:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:26:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:58 INFO - 'PWD': '/builds/slave/test', 04:26:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:26:58 INFO - 'SHELL': '/bin/bash', 04:26:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.37BrffcNBB/Listeners', 04:26:58 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 04:26:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:26:58 INFO - 'USER': 'cltbld', 04:26:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:26:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:26:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:58 INFO - 'XPC_FLAGS': '0x0', 04:26:58 INFO - 'XPC_SERVICE_NAME': '0', 04:26:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:26:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:26:58 INFO - Cleaning up... 04:26:58 INFO - Return code: 0 04:26:58 INFO - Running post-action listener: _resource_record_post_action 04:26:58 INFO - Running post-action listener: _start_resource_monitoring 04:26:58 INFO - Starting resource monitoring. 04:26:58 INFO - [mozharness: 2017-01-11 12:26:58.426589Z] Finished create-virtualenv step (success) 04:26:58 INFO - [mozharness: 2017-01-11 12:26:58.427639Z] Running install step. 04:26:58 INFO - Running pre-action listener: _resource_record_pre_action 04:26:58 INFO - Running main action method: install 04:26:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:26:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:26:58 INFO - Reading from file tmpfile_stdout 04:26:58 INFO - Detecting whether we're running mozinstall >=1.0... 04:26:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:26:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:26:58 INFO - Reading from file tmpfile_stdout 04:26:58 INFO - Output received: 04:26:58 INFO - Usage: mozinstall [options] installer 04:26:58 INFO - Options: 04:26:58 INFO - -h, --help show this help message and exit 04:26:58 INFO - -d DEST, --destination=DEST 04:26:58 INFO - Directory to install application into. [default: 04:26:58 INFO - "/builds/slave/test"] 04:26:58 INFO - --app=APP Application being installed. [default: firefox] 04:26:58 INFO - mkdir: /builds/slave/test/build/application 04:26:58 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:26:58 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:27:20 INFO - Reading from file tmpfile_stdout 04:27:20 INFO - Output received: 04:27:20 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 04:27:20 INFO - Running post-action listener: _resource_record_post_action 04:27:20 INFO - [mozharness: 2017-01-11 12:27:20.953540Z] Finished install step (success) 04:27:20 INFO - [mozharness: 2017-01-11 12:27:20.953687Z] Running run-tests step. 04:27:20 INFO - Running pre-action listener: _resource_record_pre_action 04:27:20 INFO - Running main action method: run_tests 04:27:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:27:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:27:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:27:20 INFO - 2017-01-11 04:27:20.968 screenresolution[1625:7566] starting screenresolution argv=screenresolution get 04:27:20 INFO - 2017-01-11 04:27:20.970 screenresolution[1625:7566] Display 0: 1600x1200x32@60 04:27:20 INFO - 2017-01-11 04:27:20.976 screenresolution[1626:7568] starting screenresolution argv=screenresolution list 04:27:20 INFO - Available Modes on Display 0 04:27:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:27:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:27:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:27:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:27:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:27:21 INFO - Intel Iris: 04:27:21 INFO - Chipset Model: Intel Iris 04:27:21 INFO - Type: GPU 04:27:21 INFO - Bus: Built-In 04:27:21 INFO - VRAM (Dynamic, Max): 1536 MB 04:27:21 INFO - Vendor: Intel (0x8086) 04:27:21 INFO - Device ID: 0x0a2e 04:27:21 INFO - Revision ID: 0x0009 04:27:21 INFO - Displays: 04:27:21 INFO - Display: 04:27:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:27:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:27:21 INFO - Display Serial Number: 1600x1200 60 04:27:21 INFO - Main Display: Yes 04:27:21 INFO - Mirror: Off 04:27:21 INFO - Online: Yes 04:27:21 INFO - Rotation: Supported 04:27:21 INFO - Return code: 0 04:27:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:27:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:27:21 INFO - Python 2.7.3 04:27:21 INFO - Return code: 0 04:27:21 INFO - grabbing minidump binary from tooltool 04:27:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:21 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 0x10505dd30>, '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 0x104f84db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105052be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:27:21 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:27:21 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:27:21 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:27:21 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:27:21 INFO - Return code: 0 04:27:21 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:27:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:27:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:27:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:27:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:27:21 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/KPQ0m4W3TPioLGtFx4ChlA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0321', '--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:27:21 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/KPQ0m4W3TPioLGtFx4ChlA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0321 --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:27:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AnjsRo7lbg/Render', 04:27:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:27:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:27:21 INFO - 'HOME': '/Users/cltbld', 04:27:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:27:21 INFO - 'LOGNAME': 'cltbld', 04:27:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:27:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:27:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:21 INFO - 'MOZ_NO_REMOTE': '1', 04:27:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:27:21 INFO - 'NO_EM_RESTART': '1', 04:27:21 INFO - 'PAGER': '/bin/cat', 04:27:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:27:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:21 INFO - 'PWD': '/builds/slave/test', 04:27:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:27:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:27:21 INFO - 'SHELL': '/bin/bash', 04:27:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.37BrffcNBB/Listeners', 04:27:21 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 04:27:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:27:21 INFO - 'USER': 'cltbld', 04:27:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:27:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:27:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:21 INFO - 'XPC_FLAGS': '0x0', 04:27:21 INFO - 'XPC_SERVICE_NAME': '0', 04:27:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:27:21 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/KPQ0m4W3TPioLGtFx4ChlA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0321', '--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:27:21 INFO - mozversion application_buildid: 20170111030235 04:27:21 INFO - mozversion application_changeset: 2963cf6be7f830c0d2155e2968cfc53585868a76 04:27:21 INFO - mozversion application_display_name: Nightly 04:27:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:27:21 INFO - mozversion application_name: Firefox 04:27:21 INFO - mozversion application_remotingname: firefox 04:27:21 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:27:21 INFO - mozversion application_vendor: Mozilla 04:27:21 INFO - mozversion application_version: 53.0a1 04:27:21 INFO - mozversion platform_buildid: 20170111030235 04:27:21 INFO - mozversion platform_changeset: 2963cf6be7f830c0d2155e2968cfc53585868a76 04:27:21 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:27:21 INFO - mozversion platform_version: 53.0a1 04:27:21 INFO - using testdate: 1484137641 04:27:21 INFO - actual date: 1484137641 04:27:21 INFO - starting webserver on 'localhost:49243' 04:27:21 INFO - SUITE-START | Running 2 tests 04:27:21 INFO - TEST-START | dromaeo_css 04:27:21 INFO - operating with platform_type : mac_ 04:27:21 INFO - Initialising browser for dromaeo_css test... 04:27:21 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/tmpqFJJvn/profile http://localhost:49243/getInfo.html) 04:27:24 INFO - PROCESS | 1636 | 2017-01-11 04:27:24.392 plugin-container[1639:7734] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x934b, name = 'com.apple.tsm.portname' 04:27:24 INFO - PROCESS | 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:27:24 INFO - PROCESS | 1636 | 2017-01-11 04:27:24.392 plugin-container[1639:7734] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c1f, name = 'com.apple.CFPasteboardClient' 04:27:24 INFO - PROCESS | 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:27:24 INFO - PROCESS | 1636 | 2017-01-11 04:27:24.392 plugin-container[1639:7734] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:27:24 INFO - PROCESS | 1636 | __metrics Screen width/height:1600/1200 04:27:24 INFO - PROCESS | 1636 | colorDepth:24 04:27:24 INFO - PROCESS | 1636 | Browser inner width/height: 1024/689 04:27:24 INFO - PROCESS | 1636 | __metrics 04:27:24 ERROR - PROCESS | 1636 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3252: TypeError: this.tabs is undefined 04:27:25 INFO - TEST-INFO | 1636: exit 0 04:27:25 INFO - Browser initialized. 04:27:25 INFO - Running cycle 1/1 for dromaeo_css test... 04:27:25 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/tmpqFJJvn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:27:27 INFO - PROCESS | 1640 | 2017-01-11 04:27:27.627 plugin-container[1641:7864] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4347, name = 'com.apple.tsm.portname' 04:27:27 INFO - PROCESS | 1640 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:27:27 INFO - PROCESS | 1640 | 2017-01-11 04:27:27.627 plugin-container[1641:7864] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 04:27:27 INFO - PROCESS | 1640 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:27:27 INFO - PROCESS | 1640 | 2017-01-11 04:27:27.627 plugin-container[1641:7864] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:27:37 INFO - PROCESS | 1640 | RSS: Main: 232960000 04:27:37 INFO - PROCESS | 1640 | 04:30:39 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 04:30:42 INFO - PROCESS | 1640 | RSS: Main: 254390272 04:30:42 INFO - PROCESS | 1640 | 04:32:25 INFO - PROCESS | 1640 | ************************* 04:32:25 INFO - PROCESS | 1640 | A coding exception was thrown and uncaught in a Task. 04:32:25 INFO - PROCESS | 1640 | 04:32:25 INFO - PROCESS | 1640 | Full message: ReferenceError: fetch is not defined 04:32:25 INFO - PROCESS | 1640 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 04:32:25 INFO - PROCESS | 1640 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 04:32:25 INFO - PROCESS | 1640 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 04:32:25 INFO - PROCESS | 1640 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 04:32:25 INFO - PROCESS | 1640 | TaskImpl@resource://gre/modules/Task.jsm:277:3 04:32:25 INFO - PROCESS | 1640 | asyncFunction@resource://gre/modules/Task.jsm:252:14 04:32:25 INFO - PROCESS | 1640 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 04:32:25 INFO - PROCESS | 1640 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 04:32:25 INFO - PROCESS | 1640 | TaskImpl@resource://gre/modules/Task.jsm:277:3 04:32:25 INFO - PROCESS | 1640 | asyncFunction@resource://gre/modules/Task.jsm:252:14 04:32:25 INFO - PROCESS | 1640 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 04:32:25 INFO - PROCESS | 1640 | 04:32:25 INFO - PROCESS | 1640 | ************************* 04:33:44 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 04:33:45 INFO - PROCESS | 1640 | RSS: Main: 265080832 04:33:45 INFO - PROCESS | 1640 | 04:36:47 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 04:36:47 INFO - PROCESS | 1640 | RSS: Main: 273072128 04:36:47 INFO - PROCESS | 1640 | 04:39:49 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 04:39:50 INFO - PROCESS | 1640 | RSS: Main: 270610432 04:39:50 INFO - PROCESS | 1640 | 04:42:52 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 04:42:53 INFO - PROCESS | 1640 | RSS: Main: 275304448 04:42:53 INFO - PROCESS | 1640 | 04:45:56 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 04:45:56 INFO - PROCESS | 1640 | RSS: Main: 277745664 04:45:56 INFO - PROCESS | 1640 | 04:45:56 INFO - PROCESS | 1640 | __start_tp_report 04:45:56 INFO - PROCESS | 1640 | _x_x_mozilla_page_load 04:45:56 INFO - PROCESS | 1640 | _x_x_mozilla_page_load_details 04:45:56 INFO - PROCESS | 1640 | |i|pagename|runs| 04:45:56 INFO - PROCESS | 1640 | |0;dojo.html;3034.8027378220413;3329.733621310294;3367.3097015111903;3384.5092461593063;3410.4884267359894;4297.7851107444585;4410.029793445441;5627.380988091312;5724.141378793178;5755.712214389285;5551.3893471718075;5611.270534830476;5613.971930140344;5654.095344744842;5666.376698563155;4338.110687309102;4489.393931819195;4857.344258525107;4924.80300787968;5221.660592061523;5165.741712914358;5228.973855130719;5242.004019236333;5247.606429517801;5263.26314315996;5211.4788521147775;5228.816991405301;5231.084560201968;5254.080535906221;5256.316678831747;4173.561776013506;4575.176468235716;5220.1647736362;5281.973590132063;5306.442823503535;4307.719998200107;5159.380874295071;5209.296744939423;5250.396204436501;5293.417724050351;5464.453554644543;5503.3120859892515;5632.633878797906;5693.202951586781;5792.565557583198;6121.969390153065;6198.845028874269;6216.595921265149;6249.0938813871735;6253.1558239637525;6266.968665156691;6286.622802631857;6291.811245662591;6295.842603934892;6318.304986451487;5664.065429204135;5755.65466072037;5813.941860581383;5845.181674565564;5853.239078919713;6157.96921015392;6172.444479996821;6226.346233645402;6232.875342493216;6255.43701066897;5342.305500284938;6117.797273774667;6119.99004232014;6129.908988904127;6158.076288556752;6158.599691020069;6207.099970504251;6212.627242365473;6223.408776166257;6225.533085018551;6114.2357205349335;6128.601640893327;6130.478909292671;6151.384861513813;6222.191115155091;5244.6328756987405;6120.629988696826;6126.23422072241;6146.862830376394;6147.846303842351;4989.501049894981;4990.8253211137435;4993.176125939252;5007.4491805901325;5011.3986321640905;4373.584509471595;4411.558844115627;4413.514513403523;4415.470143582791;4449.443819522559;5528.253685752452;5630.8029218977135;5698.943010569924;5759.94240057594;5816.88366232673;6195.96902015487;6204.906926396107;6209.285932117774;6263.498920086382;6305.527085468517;5810.5061069809535;5815.621984570989;5823.097419899922;5844.561657875592;5869.325027621793;5414.431484694129;5419.078756611386;5424.538914192338;5472.72636368188;5479.315085614298;6180.81457556274;6203.2556093269095;6231.563790534619;6242.406971337716;6247.875042499216;6248.625082495065;6261.186045814015;6264.248290205204;6272.749090036347;6303.527235457267;6201;6313.3686631336495;6329.272133704683;6339.904901426575;6353.4599559038;6055.757769689163;6093.390660933871;6100.908486372619;6148.78479253224;6177.722002509988;4885.047415753894;6168.691565421801;6175.907361389673;6187.288461826947;6262.405071518198;6061.72722227492;6090.908636370546;6107.8778424430375;6121.173641558511;6140.078988151634;5946.959282125525;6017.217761690952;6128.540359472968;6135.263768347649;6151.138840562415;5780.930527852361;5794.275715535558;5812.273465816773;5844.977129002493;5858.091995740667;6133.141360209485;6152.507799376129;6155.446009859134;6162.599431036968;6180.505559555135;5824.708764561839;5848.298204215522;5851.590388672752;5882.176495290748;5948.791792287249 04:45:56 INFO - PROCESS | 1640 | |1;ext.html;454.60676514814685;474.2151738872168;498.2874489480044;509.7129747387845;521.483731106205;27549.44901101979;38359.42460863089;38401.61598384015;38408;38474.230515389674;39555;40120;40154.196916061665;40177.799111004475;40313.79058628238;8226.136255693156;8432.198941100585;9018.954905225464;9289.97810240873;10860.185486088574;10907.563697452093;11151.609693660723;11166.665000050012;11179.552817887276;11190.272632278877;8728.956355218215;9686.1766749826;11173.497192626312;11197.7200569986;11202.607908723196;11119.499622516965;11128.833067503994;11150.944245278803;11154.330740155576;11181.496832642551;9611;10692.251542392036;11056.668299951014;11112.555497780078;11141;39121.41317880205;39505.40741888874;39546.20907581861;39560.40659390111;40218.59781402178;3969.6030396960364;3991.640752332304;4030.7984600769846;4044.9685330240895;4141.275276826544;25524.489510209878;28965.275868103254;29524.70475295241;30292.69707302921;30676.079717608285;3100.612423447069;3220.6618305077864;3241.7082462578483;3274.0668909360957;3284.1297056280105;485608.99999999645;487636;489779;490537;491009.5449522765;59274.40725592775;59666.70166649139;59745;59996.700016499635;60275.39724602785;61697;62148.75702485925;62441.37558624356;62599.6870015647;62644;15676.68646627061;15915.283812228477;15918.76121858173;15922;15947.36210551565;11080.5567777288;11381.374024428736;12088.335141567299;12349.691257718629;12351.505939762488;16545;16664.666706665797;16669.666606667797;16777.496675099766;16784.748228776578;7345.759543339226;7483.289087536676;7486.663100160506;7532.322091011835;7537.660805263777;870.6212797433137;881.66496731243;885.384657662931;902.3953950852945;921.4287141971886;29682.40635187284;29990.400191996476;30050.398992020037;30136.84931575328;30454.390912181632;938.8591711243369;1021.2085633633844;1090.8963648453384;1099.5107177306181;1118.139032944628;14920.47778327775;15481.845181548266;15580.220988950507;15652.843471565138;15864.60338491547;616916;618043;619692.9015354984;621401;623927;47738.522614774105;57510.7124464375;58356;58473;58705.70647146737;1413;1443.1052747296744;1458.5843034735049;1461.868431841118;1462.166565057928;29130.27174320659;29335.973240936466;29375.265618359714;30003.549946751253;30124.096277111723;48735;48875.755621221666;49487.752561238405;49514.75242623764;49590;444859;445779;445966;446198;447420.5257947509;38411.80794096012;39058;39249;39250.41124383079;39324.410133848585;40986;41550.376744349465;41711.37432938569;42204;44662.55337446584;27015.59476607813;31985;32610.51084233691;35495;36210.8189459051;26819.32951676224;29971.801127954637;30703.692963070083;32446.83776581102;34617.98039284239;25562.744372556037;34151.146221344665;34950.82524587361;35003.299934000665;35159.29681406306;30523.54214686737;31212.219694507818;31585.052448426584;31696.841515792272;31789.523157152198;23293.650595240746;23319.53360932738;23425.531489369776;23652;23700.762992370546 04:45:56 INFO - PROCESS | 1640 | |2;jquery.html;379.3778203745857;383.8541952272468;392.30366100172193;393.62605524751496;414.7552943763181;15634.921825390886;19896;20123.59752804943;21272.255471058517;21316.253931112413;19785.307514237003;20438;20614.587708245825;21190.834504102306;21251;5514.751836167382;5862.560307976897;5925.674087925162;5935.792247271346;5947.4944629706315;5401.675899446026;5816.621919575236;5905;5911.586188966774;5918.05311150216;5829.7376618052285;5878.824235152965;5886;5896.7051647417675;5901.881962360751;5580.91628625571;5845.298564172284;5870.794522191745;5871.412858714137;5877.941220587803;5825.330087040003;5826.271716035496;5832.387599302055;5835.387284335168;5860.941390586082;13320.933395333059;13422;24027.7597224029;24314.392140196458;25360.239192824243;2568.319395360231;2571.3571607098224;2609.9655932077562;2684.8254863433813;2700.9459810803673;9809.460479673615;9838.262130340254;9923.90076099237;10287.537060832281;10306.690799276033;1569.238919124224;1794.6859299622645;1832.3311991123278;1852.0554517196192;1858.9535261618569;98283;137182;139499.30250348785;139516;141854.99999999898;9413.105754953269;10575.418351990715;11958.282503049672;12042.071839650689;12202.267863928193;13789.655258618413;14324.14055156673;15454.536363909101;15554.844451555566;15577.532674019798;8239.917600824036;8571.699990500427;8582.914170858336;8707.738767836974;8802.339824513187;8392.874106888401;8396.958015209884;8439.282660973764;8484.260726551041;8511.106333834981;4703.435587729495;4796.760161991887;4802.471728109905;4866.0511200316305;4886.926696099561;1791.9104044797707;1936.7772706138692;2035.460602940222;2052.2817014045263;2058.6603210470403;878.3193025405234;888.2361169394316;956.8278858398545;972.154225823538;1058.174623793427;19115.330963416214;21609.459763505725;21738;21789.455263618536;22360.217392391187;892.9821403571892;908.7637214324191;920.9677661281823;930.1303281431883;934.8597710343503;6888.448924086061;6904.206016308089;6910.101686780787;7084.433245340463;7113.288671132846;655363;700131;726442;729583;739141;153617;158216.20891895468;158309;159486;160192.99999999767;1072.522727386321;1081.6106201767357;1102.9669109926715;1104.6741211342674;1114.8383484394878;12246;12489.437975290952;12586.307753073303;12632;12645.178063425848;50258.24612630886;58498.7075064622;59580.70209648924;59788.402115978286;60236;87311;88226;88978;89408;89436;7969.442139050211;8172.591370431336;8468.49189048659;8625.91374086251;8768.824623507622;10266.921973193006;12518.749625007631;12866.614001579968;12868.549600764303;13194.94440444743;10947.124230061736;10979.17656175774;11389.829152562885;11531.481083351437;11587.768244635228;11050.723731906766;11226.494807733508;11337.829932550854;11356.318620882774;11496.367699776592;7227.747028853965;11480.827787583026;11561.364124972872;11801.114916381477;11881.5841445549;7219.314165154302;7613.124490683642;8283.337333013224;8534.445261058012;8648.43785153963;10179.694609161737;10786.191035672198;11490.482928268415;11660.784450954292;11798.587049453228 04:45:56 INFO - PROCESS | 1640 | |3;mootools.html;1415.3206460898768;1452.9200893950829;1466.1130016340114;1481.6590985158437;1489.6946126044159;7411;7676.92323076769;7881.054273487182;8317.750467485977;8325.54209518477;7834.099078605962;8082.232187942151;8108.513489190653;8217.876731849026;8246;1954.4332143678387;2253.7971582557607;2290.828187885907;2295.231097582312;2307.4923516826357;2288.8626682399026;2314.8148148148193;2322.9419264518438;2327.453048533593;2327.627579587266;2260.2089268755967;2270.761570035147;2286.702728645274;2288.3135059482174;2290.530441259538;2247.921322753704;2249.2914731859414;2258.108047321307;2274.465500607356;2279.179495381661;2247.494313779403;2269.8070663993417;2278.088764494199;2283.760205178449;2287.656851472276;8224.136465671138;8235;8286.129956354556;8298.087210406851;8298.917010829875;4960.826371077031;5118.7696553654805;5134.948650513485;5148.794048238066;5168.819091331823;3237.465818140004;3300.2079500919845;3483.0247530691445;3488;3505.1587618971516;1177.652592485219;1219.5182902753363;1221.2184202110657;1240.4727990604047;1253.078986944595;10456.790864182674;10536.473176341153;10562.577496900114;10578.312409693346;10595.68212953605;4328.870133895988;4549.454065512094;4604.930926036112;4627.467841198238;4628.675992680547;9144.908550914539;9217.76955576116;9259.259259259243;9283.11810378013;9293.024232455495;5159.948400516022;5162.92255616166;5164.354455693038;5164.948350516522;5182.637215394886;4197.853075142417;4450.3991961085485;4655.930161047587;4729.983053643483;4735.881602959954;3709.740318177756;3761.567419746709;3772.0946972726347;3808.619138086169;3833.041739565109;1057.7567159553346;1247.9064070194772;1257.4592925042136;1263.7662032524013;1265.544404014554;821.1419067074921;880.710153600646;925.4632313258294;936.1621348892703;967.6419724701765;5198.298229738937;5808.6224395414165;5832.50423713989;5896.3219229788265;5954.702264886739;1000.1798525209404;1015.791762688647;1017.4149863828328;1018.2464975917916;1051.358671210561;3962.187751510933;4049.9595004049584;4062.435962154592;4082.1631565528996;4112.691548133902;9640.084192001748;9739.805203896025;9941.552630131662;9959.05388988045;9968.102870741668;9659.951700241594;9855.11303982645;9954.303198776017;9957.253206009433;9979.600815967426;6362;7664.616769161631;7689;7693.49992250502;7748.883766743504;5619.466150715675;5625.662460252398;5665.66006039639;5693.117566777156;5821.883562328645;8924.821503570021;8954.731358059269;8970.820583588422;9023.593938272663;9053.230475409664;9119.680811171576;9157.633694652406;9261.953690231505;9282.978872324175;9291.024442433447;6204.875902481835;6385.393387628168;6434.292227855026;6498.220213574212;6598.307177746459;7667.348275396431;7858.921410785819;7861.842763144591;7869.567173805495;7873.645685944261;6843.794686159423;7006.369426751617;7010.439164866696;7074.575525468488;7452.21751716062;6903.689333979883;6905.136857892763;6919.204291506541;6937.895931561132;6966.9651651741415;6311.305756366888;6343.460805831556;6396.552241343247;6399.840003999937;6400;4967.130752118437;4991.875203119951;5024;5064.949350506595;5073.213651883964;4846.61227101824;4935.851924442272;5011.273365362075;5112.6165537585575;5116.948830511797 04:45:56 INFO - PROCESS | 1640 | |4;prototype.html;348.1123136003191;362.77145398399006;366.26380974241766;371.17228580266016;373.46034979454697;4704.858854234379;4706.68212900388;5173.120569503184;5363.410024897258;5494.395616482184;5336.692510334964;5441.2654291670615;5469.206964990074;5477.616566840313;5490.752916118774;3466.9133271668156;3692.6676599106077;3732.2908647357053;3753.7747735135845;4313.503947046099;3829.0810205550747;4080.9183816323657;4201.159768046387;4235.49174099107;4253.680973926967;3724.608916063815;4098.5901409858925;4186.392973018926;4200.348945913388;4235.327045816901;3657.8902632921054;4254.085371645111;4265.402843601898;4268.359746038088;4271.120706888959;3156.8421578921193;3363.9159021024425;3507.526483924663;3544.858205671796;3770.3213421584105;4071.2086681859887;4200.789960501963;4603.654725895572;5314.202869569595;5316.362036555638;4415.51429342772;4526.524714904954;4945.8268960586565;4957.479464656231;4981.5267549583095;5177.016366890279;5550.833474995757;5781.843631273762;5799.3040835100055;5829.7376618052285;4022.275990321741;4112.444819949298;4161.771102589357;4170;4179.456670632799;5187.988342273258;5360.919586206171;5749.540036797046;6037.196566163333;6104.428909088145;3706.5552133744122;3923.7449565778134;3967.6230758077936;3985.282649123186;4249.022724773319;3418.6923176914197;4023.3562629979065;4031.3348297531165;4054.594540545922;4066.9389959150635;3880.1851611161974;4185.539590645027;4576.81692732287;4733.053389322081;4788.473267940523;5323.973380133075;5449.427810079964;5731.340895796953;5804.303483581997;5847.415258474119;1313.9014573906995;1315.7565850317721;1317.2689157517477;1318.971202462081;1319.769040417923;748.569572495817;824.3487644760572;824.9917500825035;870.7156943508274;878.8505953987709;4451.532589078165;4525.492743124105;4888.706677599355;5168.302279192336;5251.527362537314;5973.446903805042;5978.491828194652;5981.880362392815;5992.760289588455;6042.395760423922;4387.5393083726385;5023.874403139877;5424.321959755031;5447.12845944647;5467.863303417446;2662.813603047768;2770.030489328719;2799.020342879976;2885.855707214631;3005.9849700751793;5200.347822610496;5499.092649712833;5602.243697100839;5934;5994.841856931501;4878.5119589009155;5743.052396354555;5848;5902.704864756831;6001.819945401645;5176.611754118381;5483.835484935458;5592.350256674291;5704.914426283609;5949.732262048218;4666.976665116653;4675.129948020819;5245.580353571781;5462.781488740406;5473.397926228191;5117.795288188431;5206.921896171636;5570.61005729595;5677.886442271214;5945.554083443845;5776.844631073886;6243.063540468966;6262.373762623702;6266.530010249341;6283.3402492737605;3363.1760218745585;3668.4497325400334;3785.4700341951598;3992.900177495586;4018.3771515415156;5060.785411501287;5388.676679399248;5873.882522349614;5909.639388364701;6030;5780.161876527964;5802.216700745345;5806.82579522615;5820.185174075717;5827.358990510956;3924.6664033557468;4289.39948407217;5637.408072152529;5808.041673123887;5809.838032393623;4536.9092618148115;4691.780137164294;5468.207109968953;5566.4990150886615;5681.755706495994;5131.717755523482;5341.572674186134;5695.45893140151;5773.480386765212;5794.3626201117;5193.636445448782;5204.8178313758835;5405.378381486179;5432.918506222489;5728.885422291614 04:45:56 INFO - PROCESS | 1640 | |5;yui.html;719.9172095209052;770.0220719685999;810.5136917849287;839.5676226743225;844.3414136973162;14457.060291081085;15039.398424063038;15788.210589470538;15809;15821.367145314189;14579.343929523171;14683.412663493447;14697.118172909633;14708.632284192901;14718.63203419915;686.114911763824;704.8695991241611;849.5539841583156;859.638951640311;875.0287181228831;860.9741707748777;870.3907264914553;873.0745409865563;874.5015341255487;877.0265005843509;926.1664501948267;927.5408672707019;929.6327950459564;929.8605209218638;930.2650905784456;907.8002839375326;921.9996304010124;923.7921467669754;923.9584218710174;924.7826760711228;686.0258433025067;687.0724521895451;687.4500399680286;690.8998195261659;691.8443350246205;15042.699146017128;15338.233088345649;15428.228588570526;15438.305276262596;15584.454544091015;14286.499972501017;14680.045797023266;14730.18983955882;14774.335154918055;14783.186924719135;11687.532498700042;11811.232269902428;11860.169788114836;11917.22538035025;12336.753264934741;3236.482162853932;3724.4971928789537;3763.5860055393887;3856.9421458678144;3867.7872717000555;113595.43202283936;115248.42375788151;116335;116388.09029774238;117991.64016719618;11065.280756750786;11209.327440353441;11220.158488113424;11289.717757055974;11656.30062196271;19285.517862053563;20038.59922801565;22907.31278061661;23881.641775373384;23901.880490597436;7362.631868406558;7640.083190017122;7708.152103268636;7770.45606807518;7894.486858354188;4203.096334288081;4265.0616864289805;4284.164587905391;4290.978545107255;4314.439122914001;3531.646835316499;3611.259691763182;3617;3619.8009109498703;3649.908752281161;614.6803662095685;628.9308176100625;640.8910485217524;642.6080091144398;655.1842955520408;665.7270519087151;686.9175698916162;702.7715992302523;703.6235613946515;732.1214542548856;9887.258455615858;10315.484225788681;10348.5343159558;10708.518116684769;10710.571577136827;662.3145044878623;672.2470832667346;691.2914262880588;699.4823830365493;707.3916431868589;3789.2232092420986;4719.551642593948;4733.526647335308;4994.775235114428;5045.5459008689395;110328.38029718242;110447;111245;111814;114953;96025;98255;98971.50514247526;100336;100621.49689251508;57992;88066;88096;90324;90485.09514904898;9433.198178154933;9905.455199964072;9909.355891867006;9930.106290433896;10012.249081318785;44907.55092449034;47450;53466.465335347704;56597.43402566086;57459.1381129275;59912.70043649754;74436;76317.47365052778;77798.6110069446;77818;10340.844887326846;11819.936205741524;12071.75856482883;12314;12458.439370228543;12988.35058247065;13039;13220.86779132235;13619.523316683868;13724.245166515937;12144.817827732768;12199.902008819248;12211.877881221075;12265.816012759637;12627.242365458102;12033.819492707791;12145.453454594388;12171.939140304241;12173.87826121763;12215.69460763488;11876.226625621532;12013.81979270329;12048;12060.758784824078;12080.879191207976;8291.212334828182;9714.659986900424;10066.69799906004;10475.804879511823;10680.198985075995;9490.85763713531;9686.612535498502;9688.176504997155;9703.951480242553;9771.413715177112 04:45:56 INFO - PROCESS | 1640 | __end_tp_report 04:45:56 INFO - PROCESS | 1640 | __start_cc_report 04:45:56 INFO - PROCESS | 1640 | _x_x_mozilla_cycle_collect,375 04:45:56 INFO - PROCESS | 1640 | __end_cc_report 04:45:56 INFO - PROCESS | 1640 | __startTimestamp1484138756406__endTimestamp 04:45:56 INFO - PROCESS | 1640 | 04:45:56 INFO - PROCESS | 1640 | ------- Summary: start ------- 04:45:56 INFO - PROCESS | 1640 | Number of tests: 6 04:45:56 INFO - PROCESS | 1640 | 04:45:56 INFO - PROCESS | 1640 | [#0] dojo.html Cycles:165 Average:5671.46 Median:5851.59 stddev:689.24 (11.8%) stddev-sans-first:659.58 04:45:56 INFO - PROCESS | 1640 | Values: 3034.8 3329.7 3367.3 3384.5 3410.5 4297.8 4410.0 5627.4 5724.1 5755.7 5551.4 5611.3 5614.0 5654.1 5666.4 4338.1 4489.4 4857.3 4924.8 5221.7 5165.7 5229.0 5242.0 5247.6 5263.3 5211.5 5228.8 5231.1 5254.1 5256.3 4173.6 4575.2 5220.2 5282.0 5306.4 4307.7 5159.4 5209.3 5250.4 5293.4 5464.5 5503.3 5632.6 5693.2 5792.6 6122.0 6198.8 6216.6 6249.1 6253.2 6267.0 6286.6 6291.8 6295.8 6318.3 5664.1 5755.7 5813.9 5845.2 5853.2 6158.0 6172.4 6226.3 6232.9 6255.4 5342.3 6117.8 6120.0 6129.9 6158.1 6158.6 6207.1 6212.6 6223.4 6225.5 6114.2 6128.6 6130.5 6151.4 6222.2 5244.6 6120.6 6126.2 6146.9 6147.8 4989.5 4990.8 4993.2 5007.4 5011.4 4373.6 4411.6 4413.5 4415.5 4449.4 5528.3 5630.8 5698.9 5759.9 5816.9 6196.0 6204.9 6209.3 6263.5 6305.5 5810.5 5815.6 5823.1 5844.6 5869.3 5414.4 5419.1 5424.5 5472.7 5479.3 6180.8 6203.3 6231.6 6242.4 6247.9 6248.6 6261.2 6264.2 6272.7 6303.5 6201.0 6313.4 6329.3 6339.9 6353.5 6055.8 6093.4 6100.9 6148.8 6177.7 4885.0 6168.7 6175.9 6187.3 6262.4 6061.7 6090.9 6107.9 6121.2 6140.1 5947.0 6017.2 6128.5 6135.3 6151.1 5780.9 5794.3 5812.3 5845.0 5858.1 6133.1 6152.5 6155.4 6162.6 6180.5 5824.7 5848.3 5851.6 5882.2 5948.8 04:45:56 INFO - PROCESS | 1640 | 04:45:56 INFO - PROCESS | 1640 | [#1] ext.html Cycles:180 Average:65298.55 Median:35327.15 stddev:139694.58 (395.4%) stddev-sans-first:140001.62 04:45:56 INFO - PROCESS | 1640 | Values: 454.6 474.2 498.3 509.7 521.5 27549.4 38359.4 38401.6 38408.0 38474.2 39555.0 40120.0 40154.2 40177.8 40313.8 8226.1 8432.2 9019.0 9290.0 10860.2 10907.6 11151.6 11166.7 11179.6 11190.3 8729.0 9686.2 11173.5 11197.7 11202.6 11119.5 11128.8 11150.9 11154.3 11181.5 9611.0 10692.3 11056.7 11112.6 11141.0 39121.4 39505.4 39546.2 39560.4 40218.6 3969.6 3991.6 4030.8 4045.0 4141.3 25524.5 28965.3 29524.7 30292.7 30676.1 3100.6 3220.7 3241.7 3274.1 3284.1 485609.0 487636.0 489779.0 490537.0 491009.5 59274.4 59666.7 59745.0 59996.7 60275.4 61697.0 62148.8 62441.4 62599.7 62644.0 15676.7 15915.3 15918.8 15922.0 15947.4 11080.6 11381.4 12088.3 12349.7 12351.5 16545.0 16664.7 16669.7 16777.5 16784.7 7345.8 7483.3 7486.7 7532.3 7537.7 870.6 881.7 885.4 902.4 921.4 29682.4 29990.4 30050.4 30136.8 30454.4 938.9 1021.2 1090.9 1099.5 1118.1 14920.5 15481.8 15580.2 15652.8 15864.6 616916.0 618043.0 619692.9 621401.0 623927.0 47738.5 57510.7 58356.0 58473.0 58705.7 1413.0 1443.1 1458.6 1461.9 1462.2 29130.3 29336.0 29375.3 30003.5 30124.1 48735.0 48875.8 49487.8 49514.8 49590.0 444859.0 445779.0 445966.0 446198.0 447420.5 38411.8 39058.0 39249.0 39250.4 39324.4 40986.0 41550.4 41711.4 42204.0 44662.6 27015.6 31985.0 32610.5 35495.0 36210.8 26819.3 29971.8 30703.7 32446.8 34618.0 25562.7 34151.1 34950.8 35003.3 35159.3 30523.5 31212.2 31585.1 31696.8 31789.5 23293.7 23319.5 23425.5 23652.0 23700.8 04:45:56 INFO - PROCESS | 1640 | 04:45:56 INFO - PROCESS | 1640 | [#2] jquery.html Cycles:180 Average:39367.28 Median:381.62 stddev:118955.95 (31171.6%) stddev-sans-first:119253.63 04:45:56 INFO - PROCESS | 1640 | Values: 379.4 383.9 392.3 393.6 414.8 15634.9 19896.0 20123.6 21272.3 21316.3 19785.3 20438.0 20614.6 21190.8 21251.0 5514.8 5862.6 5925.7 5935.8 5947.5 5401.7 5816.6 5905.0 5911.6 5918.1 5829.7 5878.8 5886.0 5896.7 5901.9 5580.9 5845.3 5870.8 5871.4 5877.9 5825.3 5826.3 5832.4 5835.4 5860.9 13320.9 13422.0 24027.8 24314.4 25360.2 2568.3 2571.4 2610.0 2684.8 2700.9 9809.5 9838.3 9923.9 10287.5 10306.7 1569.2 1794.7 1832.3 1852.1 1859.0 98283.0 137182.0 139499.3 139516.0 141855.0 9413.1 10575.4 11958.3 12042.1 12202.3 13789.7 14324.1 15454.5 15554.8 15577.5 8239.9 8571.7 8582.9 8707.7 8802.3 8392.9 8397.0 8439.3 8484.3 8511.1 4703.4 4796.8 4802.5 4866.1 4886.9 1791.9 1936.8 2035.5 2052.3 2058.7 878.3 888.2 956.8 972.2 1058.2 19115.3 21609.5 21738.0 21789.5 22360.2 893.0 908.8 921.0 930.1 934.9 6888.4 6904.2 6910.1 7084.4 7113.3 655363.0 700131.0 726442.0 729583.0 739141.0 153617.0 158216.2 158309.0 159486.0 160193.0 1072.5 1081.6 1103.0 1104.7 1114.8 12246.0 12489.4 12586.3 12632.0 12645.2 50258.2 58498.7 59580.7 59788.4 60236.0 87311.0 88226.0 88978.0 89408.0 89436.0 7969.4 8172.6 8468.5 8625.9 8768.8 10266.9 12518.7 12866.6 12868.5 13194.9 10947.1 10979.2 11389.8 11531.5 11587.8 11050.7 11226.5 11337.8 11356.3 11496.4 7227.7 11480.8 11561.4 11801.1 11881.6 7219.3 7613.1 8283.3 8534.4 8648.4 10179.7 10786.2 11490.5 11660.8 11798.6 04:45:56 INFO - PROCESS | 1640 | 04:45:56 INFO - PROCESS | 1640 | [#3] mootools.html Cycles:180 Average:5369.74 Median:5163.64 stddev:2883.32 (55.8%) stddev-sans-first:2876.09 04:45:56 INFO - PROCESS | 1640 | Values: 1415.3 1452.9 1466.1 1481.7 1489.7 7411.0 7676.9 7881.1 8317.8 8325.5 7834.1 8082.2 8108.5 8217.9 8246.0 1954.4 2253.8 2290.8 2295.2 2307.5 2288.9 2314.8 2322.9 2327.5 2327.6 2260.2 2270.8 2286.7 2288.3 2290.5 2247.9 2249.3 2258.1 2274.5 2279.2 2247.5 2269.8 2278.1 2283.8 2287.7 8224.1 8235.0 8286.1 8298.1 8298.9 4960.8 5118.8 5134.9 5148.8 5168.8 3237.5 3300.2 3483.0 3488.0 3505.2 1177.7 1219.5 1221.2 1240.5 1253.1 10456.8 10536.5 10562.6 10578.3 10595.7 4328.9 4549.5 4604.9 4627.5 4628.7 9144.9 9217.8 9259.3 9283.1 9293.0 5159.9 5162.9 5164.4 5164.9 5182.6 4197.9 4450.4 4655.9 4730.0 4735.9 3709.7 3761.6 3772.1 3808.6 3833.0 1057.8 1247.9 1257.5 1263.8 1265.5 821.1 880.7 925.5 936.2 967.6 5198.3 5808.6 5832.5 5896.3 5954.7 1000.2 1015.8 1017.4 1018.2 1051.4 3962.2 4050.0 4062.4 4082.2 4112.7 9640.1 9739.8 9941.6 9959.1 9968.1 9660.0 9855.1 9954.3 9957.3 9979.6 6362.0 7664.6 7689.0 7693.5 7748.9 5619.5 5625.7 5665.7 5693.1 5821.9 8924.8 8954.7 8970.8 9023.6 9053.2 9119.7 9157.6 9262.0 9283.0 9291.0 6204.9 6385.4 6434.3 6498.2 6598.3 7667.3 7858.9 7861.8 7869.6 7873.6 6843.8 7006.4 7010.4 7074.6 7452.2 6903.7 6905.1 6919.2 6937.9 6967.0 6311.3 6343.5 6396.6 6399.8 6400.0 4967.1 4991.9 5024.0 5064.9 5073.2 4846.6 4935.9 5011.3 5112.6 5116.9 04:45:56 INFO - PROCESS | 1640 | 04:45:56 INFO - PROCESS | 1640 | [#4] prototype.html Cycles:180 Average:4568.58 Median:5170.71 stddev:1415.48 (27.4%) stddev-sans-first:1383.55 04:45:56 INFO - PROCESS | 1640 | Values: 348.1 362.8 366.3 371.2 373.5 4704.9 4706.7 5173.1 5363.4 5494.4 5336.7 5441.3 5469.2 5477.6 5490.8 3466.9 3692.7 3732.3 3753.8 4313.5 3829.1 4080.9 4201.2 4235.5 4253.7 3724.6 4098.6 4186.4 4200.3 4235.3 3657.9 4254.1 4265.4 4268.4 4271.1 3156.8 3363.9 3507.5 3544.9 3770.3 4071.2 4200.8 4603.7 5314.2 5316.4 4415.5 4526.5 4945.8 4957.5 4981.5 5177.0 5550.8 5781.8 5799.3 5829.7 4022.3 4112.4 4161.8 4170.0 4179.5 5188.0 5360.9 5749.5 6037.2 6104.4 3706.6 3923.7 3967.6 3985.3 4249.0 3418.7 4023.4 4031.3 4054.6 4066.9 3880.2 4185.5 4576.8 4733.1 4788.5 5324.0 5449.4 5731.3 5804.3 5847.4 1313.9 1315.8 1317.3 1319.0 1319.8 748.6 824.3 825.0 870.7 878.9 4451.5 4525.5 4888.7 5168.3 5251.5 5973.4 5978.5 5981.9 5992.8 6042.4 4387.5 5023.9 5424.3 5447.1 5467.9 2662.8 2770.0 2799.0 2885.9 3006.0 5200.3 5499.1 5602.2 5934.0 5994.8 4878.5 5743.1 5848.0 5902.7 6001.8 5176.6 5483.8 5592.4 5704.9 5949.7 4667.0 4675.1 5245.6 5462.8 5473.4 5117.8 5206.9 5570.6 5677.9 5945.6 5776.8 6243.1 6262.4 6266.5 6283.3 3363.2 3668.4 3785.5 3992.9 4018.4 5060.8 5388.7 5873.9 5909.6 6030.0 5780.2 5802.2 5806.8 5820.2 5827.4 3924.7 4289.4 5637.4 5808.0 5809.8 4536.9 4691.8 5468.2 5566.5 5681.8 5131.7 5341.6 5695.5 5773.5 5794.4 5193.6 5204.8 5405.4 5432.9 5728.9 04:45:56 INFO - PROCESS | 1640 | 04:45:56 INFO - PROCESS | 1640 | [#5] yui.html Cycles:180 Average:21451.90 Median:4035.44 stddev:32264.91 (799.5%) stddev-sans-first:32317.87 04:45:56 INFO - PROCESS | 1640 | Values: 719.9 770.0 810.5 839.6 844.3 14457.1 15039.4 15788.2 15809.0 15821.4 14579.3 14683.4 14697.1 14708.6 14718.6 686.1 704.9 849.6 859.6 875.0 861.0 870.4 873.1 874.5 877.0 926.2 927.5 929.6 929.9 930.3 907.8 922.0 923.8 924.0 924.8 686.0 687.1 687.5 690.9 691.8 15042.7 15338.2 15428.2 15438.3 15584.5 14286.5 14680.0 14730.2 14774.3 14783.2 11687.5 11811.2 11860.2 11917.2 12336.8 3236.5 3724.5 3763.6 3856.9 3867.8 113595.4 115248.4 116335.0 116388.1 117991.6 11065.3 11209.3 11220.2 11289.7 11656.3 19285.5 20038.6 22907.3 23881.6 23901.9 7362.6 7640.1 7708.2 7770.5 7894.5 4203.1 4265.1 4284.2 4291.0 4314.4 3531.6 3611.3 3617.0 3619.8 3649.9 614.7 628.9 640.9 642.6 655.2 665.7 686.9 702.8 703.6 732.1 9887.3 10315.5 10348.5 10708.5 10710.6 662.3 672.2 691.3 699.5 707.4 3789.2 4719.6 4733.5 4994.8 5045.5 110328.4 110447.0 111245.0 111814.0 114953.0 96025.0 98255.0 98971.5 100336.0 100621.5 57992.0 88066.0 88096.0 90324.0 90485.1 9433.2 9905.5 9909.4 9930.1 10012.2 44907.6 47450.0 53466.5 56597.4 57459.1 59912.7 74436.0 76317.5 77798.6 77818.0 10340.8 11819.9 12071.8 12314.0 12458.4 12988.4 13039.0 13220.9 13619.5 13724.2 12144.8 12199.9 12211.9 12265.8 12627.2 12033.8 12145.5 12171.9 12173.9 12215.7 11876.2 12013.8 12048.0 12060.8 12080.9 8291.2 9714.7 10066.7 10475.8 10680.2 9490.9 9686.6 9688.2 9704.0 9771.4 04:45:56 INFO - PROCESS | 1640 | -------- Summary: end -------- 04:45:56 INFO - PROCESS | 1640 | 04:45:57 INFO - TEST-INFO | 1640: exit 0 04:45:57 INFO - TEST-OK | dromaeo_css | took 1115534ms 04:45:57 INFO - TEST-START | kraken 04:45:57 INFO - operating with platform_type : mac_ 04:45:57 INFO - Initialising browser for kraken test... 04:45:57 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/tmpx1XmqG/profile http://localhost:49243/getInfo.html) 04:45:59 INFO - PROCESS | 1650 | 2017-01-11 04:45:59.635 plugin-container[1652:10188] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x893b, name = 'com.apple.tsm.portname' 04:45:59 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:45:59 INFO - PROCESS | 1650 | 2017-01-11 04:45:59.635 plugin-container[1652:10188] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4707, name = 'com.apple.CFPasteboardClient' 04:45:59 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:45:59 INFO - PROCESS | 1650 | 2017-01-11 04:45:59.635 plugin-container[1652:10188] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:45:59 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 04:45:59 INFO - PROCESS | 1650 | colorDepth:24 04:45:59 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 04:45:59 INFO - PROCESS | 1650 | __metrics 04:45:59 ERROR - PROCESS | 1650 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3252: TypeError: this.tabs is undefined 04:46:00 INFO - TEST-INFO | 1650: exit 0 04:46:00 INFO - Browser initialized. 04:46:00 INFO - Running cycle 1/1 for kraken test... 04:46:00 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/tmpx1XmqG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:46:02 INFO - PROCESS | 1653 | 2017-01-11 04:46:02.839 plugin-container[1654:10305] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 04:46:02 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:46:02 INFO - PROCESS | 1653 | 2017-01-11 04:46:02.839 plugin-container[1654:10305] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 04:46:02 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:46:02 INFO - PROCESS | 1653 | 2017-01-11 04:46:02.839 plugin-container[1654:10305] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:46:12 INFO - PROCESS | 1653 | RSS: Main: 233218048 04:46:12 INFO - PROCESS | 1653 | 04:46:15 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 04:46:16 INFO - PROCESS | 1653 | RSS: Main: 246210560 04:46:16 INFO - PROCESS | 1653 | 04:46:18 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 04:46:19 INFO - PROCESS | 1653 | RSS: Main: 254267392 04:46:19 INFO - PROCESS | 1653 | 04:46:22 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 04:46:23 INFO - PROCESS | 1653 | RSS: Main: 256684032 04:46:23 INFO - PROCESS | 1653 | 04:46:25 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 04:46:25 INFO - PROCESS | 1653 | RSS: Main: 259297280 04:46:25 INFO - PROCESS | 1653 | 04:46:27 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:46:28 INFO - PROCESS | 1653 | RSS: Main: 259751936 04:46:28 INFO - PROCESS | 1653 | 04:46:31 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 04:46:32 INFO - PROCESS | 1653 | RSS: Main: 264482816 04:46:32 INFO - PROCESS | 1653 | 04:46:35 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 04:46:36 INFO - PROCESS | 1653 | RSS: Main: 264175616 04:46:36 INFO - PROCESS | 1653 | 04:46:38 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 04:46:39 INFO - PROCESS | 1653 | RSS: Main: 264118272 04:46:39 INFO - PROCESS | 1653 | 04:46:41 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:46:41 INFO - PROCESS | 1653 | RSS: Main: 263557120 04:46:41 INFO - PROCESS | 1653 | 04:46:43 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:46:44 INFO - PROCESS | 1653 | RSS: Main: 263626752 04:46:44 INFO - PROCESS | 1653 | 04:46:46 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:46:47 INFO - PROCESS | 1653 | RSS: Main: 263598080 04:46:47 INFO - PROCESS | 1653 | 04:46:50 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:46:51 INFO - PROCESS | 1653 | RSS: Main: 263901184 04:46:51 INFO - PROCESS | 1653 | 04:46:54 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:46:55 INFO - PROCESS | 1653 | RSS: Main: 261447680 04:46:55 INFO - PROCESS | 1653 | 04:46:56 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 04:46:57 INFO - PROCESS | 1653 | RSS: Main: 263471104 04:46:57 INFO - PROCESS | 1653 | 04:46:57 INFO - PROCESS | 1653 | __start_tp_report 04:46:57 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 04:46:57 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 04:46:57 INFO - PROCESS | 1653 | |i|pagename|runs| 04:46:57 INFO - PROCESS | 1653 | |0;ai-astar;114;119;118;119;117;118;117;116;138;117 04:46:57 INFO - PROCESS | 1653 | |1;audio-beat-detection;176;93;145;183;115;145;143;129;127;112 04:46:57 INFO - PROCESS | 1653 | |2;audio-dft;194;200;199;216;199;193;193;196;198;198 04:46:57 INFO - PROCESS | 1653 | |3;audio-fft;84;59;61;89;62;60;62;82;69;70 04:46:57 INFO - PROCESS | 1653 | |4;audio-oscillator;87;71;85;71;71;71;81;71;74;82 04:46:57 INFO - PROCESS | 1653 | |5;imaging-gaussian-blur;91;90;92;118;79;132;136;94;136;119 04:46:57 INFO - PROCESS | 1653 | |6;imaging-darkroom;124;101;99;133;175;101;100;101;101;114 04:46:57 INFO - PROCESS | 1653 | |7;imaging-desaturate;101;96;92;93;93;93;92;94;93;120 04:46:57 INFO - PROCESS | 1653 | |8;json-parse-financial;57;59;59;68;89;89;89;59;58;58 04:46:57 INFO - PROCESS | 1653 | |9;json-stringify-tinderbox;67;75;62;64;75;98;59;63;92;106 04:46:57 INFO - PROCESS | 1653 | |10;stanford-crypto-aes;85;87;98;80;82;118;121;117;84;101 04:46:57 INFO - PROCESS | 1653 | |11;stanford-crypto-ccm;166;161;154;160;140;149;154;147;183;146 04:46:57 INFO - PROCESS | 1653 | |12;stanford-crypto-pbkdf2;241;180;173;172;218;244;174;225;211;177 04:46:57 INFO - PROCESS | 1653 | |13;stanford-crypto-sha256-iterative;79;89;73;64;86;88;60;77;84;91 04:46:57 INFO - PROCESS | 1653 | __end_tp_report 04:46:57 INFO - PROCESS | 1653 | __start_cc_report 04:46:57 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,919 04:46:57 INFO - PROCESS | 1653 | __end_cc_report 04:46:57 INFO - PROCESS | 1653 | __startTimestamp1484138817242__endTimestamp 04:46:57 INFO - PROCESS | 1653 | 04:46:57 INFO - PROCESS | 1653 | ------- Summary: start ------- 04:46:57 INFO - PROCESS | 1653 | Number of tests: 14 04:46:57 INFO - PROCESS | 1653 | 04:46:57 INFO - PROCESS | 1653 | [#0] ai-astar Cycles:10 Average:119.30 Median:118.00 stddev:6.73 (5.7%) stddev-sans-first:6.86 04:46:57 INFO - PROCESS | 1653 | Values: 114.0 119.0 118.0 119.0 117.0 118.0 117.0 116.0 138.0 117.0 04:46:57 INFO - PROCESS | 1653 | 04:46:57 INFO - PROCESS | 1653 | [#1] audio-beat-detection Cycles:10 Average:136.80 Median:145.00 stddev:27.91 (19.2%) stddev-sans-first:25.74 04:46:57 INFO - PROCESS | 1653 | Values: 176.0 93.0 145.0 183.0 115.0 145.0 143.0 129.0 127.0 112.0 04:46:57 INFO - PROCESS | 1653 | 04:46:57 INFO - PROCESS | 1653 | [#2] audio-dft Cycles:10 Average:198.60 Median:198.50 stddev:6.64 (3.3%) stddev-sans-first:6.83 04:46:57 INFO - PROCESS | 1653 | Values: 194.0 200.0 199.0 216.0 199.0 193.0 193.0 196.0 198.0 198.0 04:46:57 INFO - PROCESS | 1653 | 04:46:57 INFO - PROCESS | 1653 | [#3] audio-fft Cycles:10 Average:69.80 Median:69.50 stddev:11.21 (16.1%) stddev-sans-first:10.65 04:46:57 INFO - PROCESS | 1653 | Values: 84.0 59.0 61.0 89.0 62.0 60.0 62.0 82.0 69.0 70.0 04:46:57 INFO - PROCESS | 1653 | 04:46:57 INFO - PROCESS | 1653 | [#4] audio-oscillator Cycles:10 Average:76.40 Median:77.50 stddev:6.59 (8.5%) stddev-sans-first:5.76 04:46:57 INFO - PROCESS | 1653 | Values: 87.0 71.0 85.0 71.0 71.0 71.0 81.0 71.0 74.0 82.0 04:46:57 INFO - PROCESS | 1653 | 04:46:57 INFO - PROCESS | 1653 | [#5] imaging-gaussian-blur Cycles:10 Average:108.70 Median:84.50 stddev:21.77 (25.8%) stddev-sans-first:22.13 04:46:57 INFO - PROCESS | 1653 | Values: 91.0 90.0 92.0 118.0 79.0 132.0 136.0 94.0 136.0 119.0 04:46:57 INFO - PROCESS | 1653 | 04:46:57 INFO - PROCESS | 1653 | [#6] imaging-darkroom Cycles:10 Average:114.90 Median:119.00 stddev:24.20 (20.3%) stddev-sans-first:25.44 04:46:57 INFO - PROCESS | 1653 | Values: 124.0 101.0 99.0 133.0 175.0 101.0 100.0 101.0 101.0 114.0 04:46:57 INFO - PROCESS | 1653 | 04:46:57 INFO - PROCESS | 1653 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:93.00 stddev:8.62 (9.3%) stddev-sans-first:9.00 04:46:57 INFO - PROCESS | 1653 | Values: 101.0 96.0 92.0 93.0 93.0 93.0 92.0 94.0 93.0 120.0 04:46:57 INFO - PROCESS | 1653 | 04:46:57 INFO - PROCESS | 1653 | [#8] json-parse-financial Cycles:10 Average:68.50 Median:63.50 stddev:14.47 (22.8%) stddev-sans-first:14.74 04:46:57 INFO - PROCESS | 1653 | Values: 57.0 59.0 59.0 68.0 89.0 89.0 89.0 59.0 58.0 58.0 04:46:57 INFO - PROCESS | 1653 | 04:46:57 INFO - PROCESS | 1653 | [#9] json-stringify-tinderbox Cycles:10 Average:76.10 Median:71.00 stddev:16.74 (23.6%) stddev-sans-first:17.42 04:46:57 INFO - PROCESS | 1653 | Values: 67.0 75.0 62.0 64.0 75.0 98.0 59.0 63.0 92.0 106.0 04:46:57 INFO - PROCESS | 1653 | 04:46:57 INFO - PROCESS | 1653 | [#10] stanford-crypto-aes Cycles:10 Average:97.30 Median:83.00 stddev:16.19 (19.5%) stddev-sans-first:16.55 04:46:57 INFO - PROCESS | 1653 | Values: 85.0 87.0 98.0 80.0 82.0 118.0 121.0 117.0 84.0 101.0 04:46:57 INFO - PROCESS | 1653 | 04:46:57 INFO - PROCESS | 1653 | [#11] stanford-crypto-ccm Cycles:10 Average:156.00 Median:157.00 stddev:12.31 (7.8%) stddev-sans-first:12.51 04:46:57 INFO - PROCESS | 1653 | Values: 166.0 161.0 154.0 160.0 140.0 149.0 154.0 147.0 183.0 146.0 04:46:57 INFO - PROCESS | 1653 | 04:46:57 INFO - PROCESS | 1653 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:201.50 Median:214.50 stddev:29.41 (13.7%) stddev-sans-first:27.50 04:46:57 INFO - PROCESS | 1653 | Values: 241.0 180.0 173.0 172.0 218.0 244.0 174.0 225.0 211.0 177.0 04:46:57 INFO - PROCESS | 1653 | 04:46:57 INFO - PROCESS | 1653 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:79.10 Median:85.00 stddev:10.67 (12.6%) stddev-sans-first:11.32 04:46:57 INFO - PROCESS | 1653 | Values: 79.0 89.0 73.0 64.0 86.0 88.0 60.0 77.0 84.0 91.0 04:46:57 INFO - PROCESS | 1653 | -------- Summary: end -------- 04:46:57 INFO - PROCESS | 1653 | 04:46:58 INFO - TEST-INFO | 1653: exit 0 04:46:58 INFO - TEST-OK | kraken | took 61029ms 04:46:58 INFO - SUITE-END | took 1176s 04:46:58 INFO - Completed test suite (00:19:36) 04:46:58 INFO - javascript benchmark 04:46:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7239.194467713919, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3034.8027378220413, 3329.733621310294, 3367.3097015111903, 3384.5092461593063, 3410.4884267359894, 4297.7851107444585, 4410.029793445441, 5627.380988091312, 5724.141378793178, 5755.712214389285, 5551.3893471718075, 5611.270534830476, 5613.971930140344, 5654.095344744842, 5666.376698563155, 4338.110687309102, 4489.393931819195, 4857.344258525107, 4924.80300787968, 5221.660592061523, 5165.741712914358, 5228.973855130719, 5242.004019236333, 5247.606429517801, 5263.26314315996, 5211.4788521147775, 5228.816991405301, 5231.084560201968, 5254.080535906221, 5256.316678831747, 4173.561776013506, 4575.176468235716, 5220.1647736362, 5281.973590132063, 5306.442823503535, 4307.719998200107, 5159.380874295071, 5209.296744939423, 5250.396204436501, 5293.417724050351, 5464.453554644543, 5503.3120859892515, 5632.633878797906, 5693.202951586781, 5792.565557583198, 6121.969390153065, 6198.845028874269, 6216.595921265149, 6249.0938813871735, 6253.1558239637525, 6266.968665156691, 6286.622802631857, 6291.811245662591, 6295.842603934892, 6318.304986451487, 5664.065429204135, 5755.65466072037, 5813.941860581383, 5845.181674565564, 5853.239078919713, 6157.96921015392, 6172.444479996821, 6226.346233645402, 6232.875342493216, 6255.43701066897, 5342.305500284938, 6117.797273774667, 6119.99004232014, 6129.908988904127, 6158.076288556752, 6158.599691020069, 6207.099970504251, 6212.627242365473, 6223.408776166257, 6225.533085018551, 6114.2357205349335, 6128.601640893327, 6130.478909292671, 6151.384861513813, 6222.191115155091, 5244.6328756987405, 6120.629988696826, 6126.23422072241, 6146.862830376394, 6147.846303842351, 4989.501049894981, 4990.8253211137435, 4993.176125939252, 5007.4491805901325, 5011.3986321640905, 4373.584509471595, 4411.558844115627, 4413.514513403523, 4415.470143582791, 4449.443819522559, 5528.253685752452, 5630.8029218977135, 5698.943010569924, 5759.94240057594, 5816.88366232673, 6195.96902015487, 6204.906926396107, 6209.285932117774, 6263.498920086382, 6305.527085468517, 5810.5061069809535, 5815.621984570989, 5823.097419899922, 5844.561657875592, 5869.325027621793, 5414.431484694129, 5419.078756611386, 5424.538914192338, 5472.72636368188, 5479.315085614298, 6180.81457556274, 6203.2556093269095, 6231.563790534619, 6242.406971337716, 6247.875042499216, 6248.625082495065, 6261.186045814015, 6264.248290205204, 6272.749090036347, 6303.527235457267, 6201.0, 6313.3686631336495, 6329.272133704683, 6339.904901426575, 6353.4599559038, 6055.757769689163, 6093.390660933871, 6100.908486372619, 6148.78479253224, 6177.722002509988, 4885.047415753894, 6168.691565421801, 6175.907361389673, 6187.288461826947, 6262.405071518198, 6061.72722227492, 6090.908636370546, 6107.8778424430375, 6121.173641558511, 6140.078988151634, 5946.959282125525, 6017.217761690952, 6128.540359472968, 6135.263768347649, 6151.138840562415, 5780.930527852361, 5794.275715535558, 5812.273465816773, 5844.977129002493, 5858.091995740667, 6133.141360209485, 6152.507799376129, 6155.446009859134, 6162.599431036968, 6180.505559555135, 5824.708764561839, 5848.298204215522, 5851.590388672752, 5882.176495290748, 5948.791792287249], "value": 5626.951437297998, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [454.60676514814685, 474.2151738872168, 498.2874489480044, 509.7129747387845, 521.483731106205, 27549.44901101979, 38359.42460863089, 38401.61598384015, 38408.0, 38474.230515389674, 39555.0, 40120.0, 40154.196916061665, 40177.799111004475, 40313.79058628238, 8226.136255693156, 8432.198941100585, 9018.954905225464, 9289.97810240873, 10860.185486088574, 10907.563697452093, 11151.609693660723, 11166.665000050012, 11179.552817887276, 11190.272632278877, 8728.956355218215, 9686.1766749826, 11173.497192626312, 11197.7200569986, 11202.607908723196, 11119.499622516965, 11128.833067503994, 11150.944245278803, 11154.330740155576, 11181.496832642551, 9611.0, 10692.251542392036, 11056.668299951014, 11112.555497780078, 11141.0, 39121.41317880205, 39505.40741888874, 39546.20907581861, 39560.40659390111, 40218.59781402178, 3969.6030396960364, 3991.640752332304, 4030.7984600769846, 4044.9685330240895, 4141.275276826544, 25524.489510209878, 28965.275868103254, 29524.70475295241, 30292.69707302921, 30676.079717608285, 3100.612423447069, 3220.6618305077864, 3241.7082462578483, 3274.0668909360957, 3284.1297056280105, 485608.99999999645, 487636.0, 489779.0, 490537.0, 491009.5449522765, 59274.40725592775, 59666.70166649139, 59745.0, 59996.700016499635, 60275.39724602785, 61697.0, 62148.75702485925, 62441.37558624356, 62599.6870015647, 62644.0, 15676.68646627061, 15915.283812228477, 15918.76121858173, 15922.0, 15947.36210551565, 11080.5567777288, 11381.374024428736, 12088.335141567299, 12349.691257718629, 12351.505939762488, 16545.0, 16664.666706665797, 16669.666606667797, 16777.496675099766, 16784.748228776578, 7345.759543339226, 7483.289087536676, 7486.663100160506, 7532.322091011835, 7537.660805263777, 870.6212797433137, 881.66496731243, 885.384657662931, 902.3953950852945, 921.4287141971886, 29682.40635187284, 29990.400191996476, 30050.398992020037, 30136.84931575328, 30454.390912181632, 938.8591711243369, 1021.2085633633844, 1090.8963648453384, 1099.5107177306181, 1118.139032944628, 14920.47778327775, 15481.845181548266, 15580.220988950507, 15652.843471565138, 15864.60338491547, 616916.0, 618043.0, 619692.9015354984, 621401.0, 623927.0, 47738.522614774105, 57510.7124464375, 58356.0, 58473.0, 58705.70647146737, 1413.0, 1443.1052747296744, 1458.5843034735049, 1461.868431841118, 1462.166565057928, 29130.27174320659, 29335.973240936466, 29375.265618359714, 30003.549946751253, 30124.096277111723, 48735.0, 48875.755621221666, 49487.752561238405, 49514.75242623764, 49590.0, 444859.0, 445779.0, 445966.0, 446198.0, 447420.5257947509, 38411.80794096012, 39058.0, 39249.0, 39250.41124383079, 39324.410133848585, 40986.0, 41550.376744349465, 41711.37432938569, 42204.0, 44662.55337446584, 27015.59476607813, 31985.0, 32610.51084233691, 35495.0, 36210.8189459051, 26819.32951676224, 29971.801127954637, 30703.692963070083, 32446.83776581102, 34617.98039284239, 25562.744372556037, 34151.146221344665, 34950.82524587361, 35003.299934000665, 35159.29681406306, 30523.54214686737, 31212.219694507818, 31585.052448426584, 31696.841515792272, 31789.523157152198, 23293.650595240746, 23319.53360932738, 23425.531489369776, 23652.0, 23700.762992370546], "value": 19607.499780008224, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.3778203745857, 383.8541952272468, 392.30366100172193, 393.62605524751496, 414.7552943763181, 15634.921825390886, 19896.0, 20123.59752804943, 21272.255471058517, 21316.253931112413, 19785.307514237003, 20438.0, 20614.587708245825, 21190.834504102306, 21251.0, 5514.751836167382, 5862.560307976897, 5925.674087925162, 5935.792247271346, 5947.4944629706315, 5401.675899446026, 5816.621919575236, 5905.0, 5911.586188966774, 5918.05311150216, 5829.7376618052285, 5878.824235152965, 5886.0, 5896.7051647417675, 5901.881962360751, 5580.91628625571, 5845.298564172284, 5870.794522191745, 5871.412858714137, 5877.941220587803, 5825.330087040003, 5826.271716035496, 5832.387599302055, 5835.387284335168, 5860.941390586082, 13320.933395333059, 13422.0, 24027.7597224029, 24314.392140196458, 25360.239192824243, 2568.319395360231, 2571.3571607098224, 2609.9655932077562, 2684.8254863433813, 2700.9459810803673, 9809.460479673615, 9838.262130340254, 9923.90076099237, 10287.537060832281, 10306.690799276033, 1569.238919124224, 1794.6859299622645, 1832.3311991123278, 1852.0554517196192, 1858.9535261618569, 98283.0, 137182.0, 139499.30250348785, 139516.0, 141854.99999999898, 9413.105754953269, 10575.418351990715, 11958.282503049672, 12042.071839650689, 12202.267863928193, 13789.655258618413, 14324.14055156673, 15454.536363909101, 15554.844451555566, 15577.532674019798, 8239.917600824036, 8571.699990500427, 8582.914170858336, 8707.738767836974, 8802.339824513187, 8392.874106888401, 8396.958015209884, 8439.282660973764, 8484.260726551041, 8511.106333834981, 4703.435587729495, 4796.760161991887, 4802.471728109905, 4866.0511200316305, 4886.926696099561, 1791.9104044797707, 1936.7772706138692, 2035.460602940222, 2052.2817014045263, 2058.6603210470403, 878.3193025405234, 888.2361169394316, 956.8278858398545, 972.154225823538, 1058.174623793427, 19115.330963416214, 21609.459763505725, 21738.0, 21789.455263618536, 22360.217392391187, 892.9821403571892, 908.7637214324191, 920.9677661281823, 930.1303281431883, 934.8597710343503, 6888.448924086061, 6904.206016308089, 6910.101686780787, 7084.433245340463, 7113.288671132846, 655363.0, 700131.0, 726442.0, 729583.0, 739141.0, 153617.0, 158216.20891895468, 158309.0, 159486.0, 160192.99999999767, 1072.522727386321, 1081.6106201767357, 1102.9669109926715, 1104.6741211342674, 1114.8383484394878, 12246.0, 12489.437975290952, 12586.307753073303, 12632.0, 12645.178063425848, 50258.24612630886, 58498.7075064622, 59580.70209648924, 59788.402115978286, 60236.0, 87311.0, 88226.0, 88978.0, 89408.0, 89436.0, 7969.442139050211, 8172.591370431336, 8468.49189048659, 8625.91374086251, 8768.824623507622, 10266.921973193006, 12518.749625007631, 12866.614001579968, 12868.549600764303, 13194.94440444743, 10947.124230061736, 10979.17656175774, 11389.829152562885, 11531.481083351437, 11587.768244635228, 11050.723731906766, 11226.494807733508, 11337.829932550854, 11356.318620882774, 11496.367699776592, 7227.747028853965, 11480.827787583026, 11561.364124972872, 11801.114916381477, 11881.5841445549, 7219.314165154302, 7613.124490683642, 8283.337333013224, 8534.445261058012, 8648.43785153963, 10179.694609161737, 10786.191035672198, 11490.482928268415, 11660.784450954292, 11798.587049453228], "value": 9566.833276123325, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1415.3206460898768, 1452.9200893950829, 1466.1130016340114, 1481.6590985158437, 1489.6946126044159, 7411.0, 7676.92323076769, 7881.054273487182, 8317.750467485977, 8325.54209518477, 7834.099078605962, 8082.232187942151, 8108.513489190653, 8217.876731849026, 8246.0, 1954.4332143678387, 2253.7971582557607, 2290.828187885907, 2295.231097582312, 2307.4923516826357, 2288.8626682399026, 2314.8148148148193, 2322.9419264518438, 2327.453048533593, 2327.627579587266, 2260.2089268755967, 2270.761570035147, 2286.702728645274, 2288.3135059482174, 2290.530441259538, 2247.921322753704, 2249.2914731859414, 2258.108047321307, 2274.465500607356, 2279.179495381661, 2247.494313779403, 2269.8070663993417, 2278.088764494199, 2283.760205178449, 2287.656851472276, 8224.136465671138, 8235.0, 8286.129956354556, 8298.087210406851, 8298.917010829875, 4960.826371077031, 5118.7696553654805, 5134.948650513485, 5148.794048238066, 5168.819091331823, 3237.465818140004, 3300.2079500919845, 3483.0247530691445, 3488.0, 3505.1587618971516, 1177.652592485219, 1219.5182902753363, 1221.2184202110657, 1240.4727990604047, 1253.078986944595, 10456.790864182674, 10536.473176341153, 10562.577496900114, 10578.312409693346, 10595.68212953605, 4328.870133895988, 4549.454065512094, 4604.930926036112, 4627.467841198238, 4628.675992680547, 9144.908550914539, 9217.76955576116, 9259.259259259243, 9283.11810378013, 9293.024232455495, 5159.948400516022, 5162.92255616166, 5164.354455693038, 5164.948350516522, 5182.637215394886, 4197.853075142417, 4450.3991961085485, 4655.930161047587, 4729.983053643483, 4735.881602959954, 3709.740318177756, 3761.567419746709, 3772.0946972726347, 3808.619138086169, 3833.041739565109, 1057.7567159553346, 1247.9064070194772, 1257.4592925042136, 1263.7662032524013, 1265.544404014554, 821.1419067074921, 880.710153600646, 925.4632313258294, 936.1621348892703, 967.6419724701765, 5198.298229738937, 5808.6224395414165, 5832.50423713989, 5896.3219229788265, 5954.702264886739, 1000.1798525209404, 1015.791762688647, 1017.4149863828328, 1018.2464975917916, 1051.358671210561, 3962.187751510933, 4049.9595004049584, 4062.435962154592, 4082.1631565528996, 4112.691548133902, 9640.084192001748, 9739.805203896025, 9941.552630131662, 9959.05388988045, 9968.102870741668, 9659.951700241594, 9855.11303982645, 9954.303198776017, 9957.253206009433, 9979.600815967426, 6362.0, 7664.616769161631, 7689.0, 7693.49992250502, 7748.883766743504, 5619.466150715675, 5625.662460252398, 5665.66006039639, 5693.117566777156, 5821.883562328645, 8924.821503570021, 8954.731358059269, 8970.820583588422, 9023.593938272663, 9053.230475409664, 9119.680811171576, 9157.633694652406, 9261.953690231505, 9282.978872324175, 9291.024442433447, 6204.875902481835, 6385.393387628168, 6434.292227855026, 6498.220213574212, 6598.307177746459, 7667.348275396431, 7858.921410785819, 7861.842763144591, 7869.567173805495, 7873.645685944261, 6843.794686159423, 7006.369426751617, 7010.439164866696, 7074.575525468488, 7452.21751716062, 6903.689333979883, 6905.136857892763, 6919.204291506541, 6937.895931561132, 6966.9651651741415, 6311.305756366888, 6343.460805831556, 6396.552241343247, 6399.840003999937, 6400.0, 4967.130752118437, 4991.875203119951, 5024.0, 5064.949350506595, 5073.213651883964, 4846.61227101824, 4935.851924442272, 5011.273365362075, 5112.6165537585575, 5116.948830511797], "value": 4393.309615245789, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.1123136003191, 362.77145398399006, 366.26380974241766, 371.17228580266016, 373.46034979454697, 4704.858854234379, 4706.68212900388, 5173.120569503184, 5363.410024897258, 5494.395616482184, 5336.692510334964, 5441.2654291670615, 5469.206964990074, 5477.616566840313, 5490.752916118774, 3466.9133271668156, 3692.6676599106077, 3732.2908647357053, 3753.7747735135845, 4313.503947046099, 3829.0810205550747, 4080.9183816323657, 4201.159768046387, 4235.49174099107, 4253.680973926967, 3724.608916063815, 4098.5901409858925, 4186.392973018926, 4200.348945913388, 4235.327045816901, 3657.8902632921054, 4254.085371645111, 4265.402843601898, 4268.359746038088, 4271.120706888959, 3156.8421578921193, 3363.9159021024425, 3507.526483924663, 3544.858205671796, 3770.3213421584105, 4071.2086681859887, 4200.789960501963, 4603.654725895572, 5314.202869569595, 5316.362036555638, 4415.51429342772, 4526.524714904954, 4945.8268960586565, 4957.479464656231, 4981.5267549583095, 5177.016366890279, 5550.833474995757, 5781.843631273762, 5799.3040835100055, 5829.7376618052285, 4022.275990321741, 4112.444819949298, 4161.771102589357, 4170.0, 4179.456670632799, 5187.988342273258, 5360.919586206171, 5749.540036797046, 6037.196566163333, 6104.428909088145, 3706.5552133744122, 3923.7449565778134, 3967.6230758077936, 3985.282649123186, 4249.022724773319, 3418.6923176914197, 4023.3562629979065, 4031.3348297531165, 4054.594540545922, 4066.9389959150635, 3880.1851611161974, 4185.539590645027, 4576.81692732287, 4733.053389322081, 4788.473267940523, 5323.973380133075, 5449.427810079964, 5731.340895796953, 5804.303483581997, 5847.415258474119, 1313.9014573906995, 1315.7565850317721, 1317.2689157517477, 1318.971202462081, 1319.769040417923, 748.569572495817, 824.3487644760572, 824.9917500825035, 870.7156943508274, 878.8505953987709, 4451.532589078165, 4525.492743124105, 4888.706677599355, 5168.302279192336, 5251.527362537314, 5973.446903805042, 5978.491828194652, 5981.880362392815, 5992.760289588455, 6042.395760423922, 4387.5393083726385, 5023.874403139877, 5424.321959755031, 5447.12845944647, 5467.863303417446, 2662.813603047768, 2770.030489328719, 2799.020342879976, 2885.855707214631, 3005.9849700751793, 5200.347822610496, 5499.092649712833, 5602.243697100839, 5934.0, 5994.841856931501, 4878.5119589009155, 5743.052396354555, 5848.0, 5902.704864756831, 6001.819945401645, 5176.611754118381, 5483.835484935458, 5592.350256674291, 5704.914426283609, 5949.732262048218, 4666.976665116653, 4675.129948020819, 5245.580353571781, 5462.781488740406, 5473.397926228191, 5117.795288188431, 5206.921896171636, 5570.61005729595, 5677.886442271214, 5945.554083443845, 5776.844631073886, 6243.063540468966, 6262.373762623702, 6266.530010249341, 6283.3402492737605, 3363.1760218745585, 3668.4497325400334, 3785.4700341951598, 3992.900177495586, 4018.3771515415156, 5060.785411501287, 5388.676679399248, 5873.882522349614, 5909.639388364701, 6030.0, 5780.161876527964, 5802.216700745345, 5806.82579522615, 5820.185174075717, 5827.358990510956, 3924.6664033557468, 4289.39948407217, 5637.408072152529, 5808.041673123887, 5809.838032393623, 4536.9092618148115, 4691.780137164294, 5468.207109968953, 5566.4990150886615, 5681.755706495994, 5131.717755523482, 5341.572674186134, 5695.45893140151, 5773.480386765212, 5794.3626201117, 5193.636445448782, 5204.8178313758835, 5405.378381486179, 5432.918506222489, 5728.885422291614], "value": 4130.220343094787, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [719.9172095209052, 770.0220719685999, 810.5136917849287, 839.5676226743225, 844.3414136973162, 14457.060291081085, 15039.398424063038, 15788.210589470538, 15809.0, 15821.367145314189, 14579.343929523171, 14683.412663493447, 14697.118172909633, 14708.632284192901, 14718.63203419915, 686.114911763824, 704.8695991241611, 849.5539841583156, 859.638951640311, 875.0287181228831, 860.9741707748777, 870.3907264914553, 873.0745409865563, 874.5015341255487, 877.0265005843509, 926.1664501948267, 927.5408672707019, 929.6327950459564, 929.8605209218638, 930.2650905784456, 907.8002839375326, 921.9996304010124, 923.7921467669754, 923.9584218710174, 924.7826760711228, 686.0258433025067, 687.0724521895451, 687.4500399680286, 690.8998195261659, 691.8443350246205, 15042.699146017128, 15338.233088345649, 15428.228588570526, 15438.305276262596, 15584.454544091015, 14286.499972501017, 14680.045797023266, 14730.18983955882, 14774.335154918055, 14783.186924719135, 11687.532498700042, 11811.232269902428, 11860.169788114836, 11917.22538035025, 12336.753264934741, 3236.482162853932, 3724.4971928789537, 3763.5860055393887, 3856.9421458678144, 3867.7872717000555, 113595.43202283936, 115248.42375788151, 116335.0, 116388.09029774238, 117991.64016719618, 11065.280756750786, 11209.327440353441, 11220.158488113424, 11289.717757055974, 11656.30062196271, 19285.517862053563, 20038.59922801565, 22907.31278061661, 23881.641775373384, 23901.880490597436, 7362.631868406558, 7640.083190017122, 7708.152103268636, 7770.45606807518, 7894.486858354188, 4203.096334288081, 4265.0616864289805, 4284.164587905391, 4290.978545107255, 4314.439122914001, 3531.646835316499, 3611.259691763182, 3617.0, 3619.8009109498703, 3649.908752281161, 614.6803662095685, 628.9308176100625, 640.8910485217524, 642.6080091144398, 655.1842955520408, 665.7270519087151, 686.9175698916162, 702.7715992302523, 703.6235613946515, 732.1214542548856, 9887.258455615858, 10315.484225788681, 10348.5343159558, 10708.518116684769, 10710.571577136827, 662.3145044878623, 672.2470832667346, 691.2914262880588, 699.4823830365493, 707.3916431868589, 3789.2232092420986, 4719.551642593948, 4733.526647335308, 4994.775235114428, 5045.5459008689395, 110328.38029718242, 110447.0, 111245.0, 111814.0, 114953.0, 96025.0, 98255.0, 98971.50514247526, 100336.0, 100621.49689251508, 57992.0, 88066.0, 88096.0, 90324.0, 90485.09514904898, 9433.198178154933, 9905.455199964072, 9909.355891867006, 9930.106290433896, 10012.249081318785, 44907.55092449034, 47450.0, 53466.465335347704, 56597.43402566086, 57459.1381129275, 59912.70043649754, 74436.0, 76317.47365052778, 77798.6110069446, 77818.0, 10340.844887326846, 11819.936205741524, 12071.75856482883, 12314.0, 12458.439370228543, 12988.35058247065, 13039.0, 13220.86779132235, 13619.523316683868, 13724.245166515937, 12144.817827732768, 12199.902008819248, 12211.877881221075, 12265.816012759637, 12627.242365458102, 12033.819492707791, 12145.453454594388, 12171.939140304241, 12173.87826121763, 12215.69460763488, 11876.226625621532, 12013.81979270329, 12048.0, 12060.758784824078, 12080.879191207976, 8291.212334828182, 9714.659986900424, 10066.69799906004, 10475.804879511823, 10680.198985075995, 9490.85763713531, 9686.612535498502, 9688.176504997155, 9703.951480242553, 9771.413715177112], "value": 7513.91490584056, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1599.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 119.0, 118.0, 119.0, 117.0, 118.0, 117.0, 116.0, 138.0, 117.0], "value": 119.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 93.0, 145.0, 183.0, 115.0, 145.0, 143.0, 129.0, 127.0, 112.0], "value": 136.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 200.0, 199.0, 216.0, 199.0, 193.0, 193.0, 196.0, 198.0, 198.0], "value": 198.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 59.0, 61.0, 89.0, 62.0, 60.0, 62.0, 82.0, 69.0, 70.0], "value": 69.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 71.0, 85.0, 71.0, 71.0, 71.0, 81.0, 71.0, 74.0, 82.0], "value": 76.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 90.0, 92.0, 118.0, 79.0, 132.0, 136.0, 94.0, 136.0, 119.0], "value": 108.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 101.0, 99.0, 133.0, 175.0, 101.0, 100.0, 101.0, 101.0, 114.0], "value": 114.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 96.0, 92.0, 93.0, 93.0, 93.0, 92.0, 94.0, 93.0, 120.0], "value": 96.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 59.0, 59.0, 68.0, 89.0, 89.0, 89.0, 59.0, 58.0, 58.0], "value": 68.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 75.0, 62.0, 64.0, 75.0, 98.0, 59.0, 63.0, 92.0, 106.0], "value": 76.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 98.0, 80.0, 82.0, 118.0, 121.0, 117.0, 84.0, 101.0], "value": 97.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 161.0, 154.0, 160.0, 140.0, 149.0, 154.0, 147.0, 183.0, 146.0], "value": 156.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [241.0, 180.0, 173.0, 172.0, 218.0, 244.0, 174.0, 225.0, 211.0, 177.0], "value": 201.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 89.0, 73.0, 64.0, 86.0, 88.0, 60.0, 77.0, 84.0, 91.0], "value": 79.1, "unit": "score"}]}]} 04:46:58 INFO - Return code: 0 04:46:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:46:58 ERROR - # TBPL SUCCESS # 04:46:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:46:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:46:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:46:58 INFO - 2017-01-11 04:46:58.511 screenresolution[1658:10697] starting screenresolution argv=screenresolution get 04:46:58 INFO - 2017-01-11 04:46:58.515 screenresolution[1658:10697] Display 0: 1600x1200x32@60 04:46:58 INFO - 2017-01-11 04:46:58.521 screenresolution[1659:10700] starting screenresolution argv=screenresolution list 04:46:58 INFO - Available Modes on Display 0 04:46:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:46:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:46:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:46:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:46:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:46:58 INFO - Intel Iris: 04:46:58 INFO - Chipset Model: Intel Iris 04:46:58 INFO - Type: GPU 04:46:58 INFO - Bus: Built-In 04:46:58 INFO - VRAM (Dynamic, Max): 1536 MB 04:46:58 INFO - Vendor: Intel (0x8086) 04:46:58 INFO - Device ID: 0x0a2e 04:46:58 INFO - Revision ID: 0x0009 04:46:58 INFO - Displays: 04:46:58 INFO - Display: 04:46:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:46:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:46:58 INFO - Display Serial Number: 1600x1200 60 04:46:58 INFO - Main Display: Yes 04:46:58 INFO - Mirror: Off 04:46:58 INFO - Online: Yes 04:46:58 INFO - Rotation: Supported 04:46:58 INFO - Return code: 0 04:46:58 INFO - Running post-action listener: _resource_record_post_action 04:46:58 INFO - [mozharness: 2017-01-11 12:46:58.766011Z] Finished run-tests step (success) 04:46:58 INFO - Running post-run listener: _resource_record_post_run 04:46:58 INFO - Total resource usage - Wall time: 1199s; CPU: 54.0%; Read bytes: 39114752; Write bytes: 553088512; Read time: 244; Write time: 1678 04:46:58 INFO - TinderboxPrint: CPU usage
54.3% 04:46:58 INFO - TinderboxPrint: I/O read bytes / time
39,114,752 / 244 04:46:58 INFO - TinderboxPrint: I/O write bytes / time
553,088,512 / 1,678 04:46:58 INFO - TinderboxPrint: CPU idle
2,193.6 (45.7%) 04:46:58 INFO - TinderboxPrint: CPU system
964.7 (20.1%) 04:46:58 INFO - TinderboxPrint: CPU user
1,639.3 (34.2%) 04:46:58 INFO - TinderboxPrint: Swap in / out
289,492,992 / 0 04:46:58 INFO - install - Wall time: 23s; CPU: 55.0%; Read bytes: 245504512; Write bytes: 232423424; Read time: 17475; Write time: 488 04:46:58 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 31752192; Write bytes: 301237760; Read time: 184; Write time: 1142 04:46:59 INFO - Running post-run listener: _upload_blobber_files 04:46:59 INFO - Blob upload gear active. 04:46:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:46:59 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:46:59 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:46:59 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:46:59 INFO - (blobuploader) - INFO - Open directory for files ... 04:46:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:46:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:46:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:47:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:47:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:47:00 INFO - (blobuploader) - INFO - Done attempting. 04:47:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:47:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:47:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:47:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:47:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:47:01 INFO - (blobuploader) - INFO - Done attempting. 04:47:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:47:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:47:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:47:02 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:47:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:47:02 INFO - (blobuploader) - INFO - Done attempting. 04:47:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:47:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:47:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:47:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:47:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:47:05 INFO - (blobuploader) - INFO - Done attempting. 04:47:05 INFO - (blobuploader) - INFO - Iteration through files over. 04:47:05 INFO - Return code: 0 04:47:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:47:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:47:05 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bdbee65a77f6549f53e6583793b574a6d1fae640dffd2ba46765c25bf5359bc8edef242ff273c8bb810cf661d9609d38ef39c2eb6c2c96649b7a1ee79aa8a6db", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/83175b1ca88134a3e886c55f3b3c198031760b998f5cd961ff40f7d17a6e47529854c4d3d549d713536ad8b70bdbce68ec687821496c456ce289154703a3dcdc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/41c3f2861ab3d1a3b5c3e4449e6c9db01be4b9f183a17759d0a00b9f07ae28b29c9bda0b5449d0f52241ce665600a5bdb7a2582cf5021e391c3822a7cc620232", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/63d3e52270a4db91e4d3d6cb6936dae367c1233b9d87322a1fd37bbd47d882243986276dc92b2ed1fb4356acebd85f7a919eede9cdb97aaca98f148bec460d17"} 04:47:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:47:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:47:05 INFO - Contents: 04:47:05 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bdbee65a77f6549f53e6583793b574a6d1fae640dffd2ba46765c25bf5359bc8edef242ff273c8bb810cf661d9609d38ef39c2eb6c2c96649b7a1ee79aa8a6db", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/83175b1ca88134a3e886c55f3b3c198031760b998f5cd961ff40f7d17a6e47529854c4d3d549d713536ad8b70bdbce68ec687821496c456ce289154703a3dcdc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/41c3f2861ab3d1a3b5c3e4449e6c9db01be4b9f183a17759d0a00b9f07ae28b29c9bda0b5449d0f52241ce665600a5bdb7a2582cf5021e391c3822a7cc620232", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/63d3e52270a4db91e4d3d6cb6936dae367c1233b9d87322a1fd37bbd47d882243986276dc92b2ed1fb4356acebd85f7a919eede9cdb97aaca98f148bec460d17"} 04:47:05 INFO - Running post-run listener: copy_logs_to_upload_dir 04:47:05 INFO - Copying logs to upload dir... 04:47:05 INFO - mkdir: /builds/slave/test/build/upload/logs 04:47:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.309596 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-01-11 04:47:05.313056) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-11 04:47:05.316959) ========= 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.AnjsRo7lbg/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.37BrffcNBB/Listeners TMPDIR=/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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/bdbee65a77f6549f53e6583793b574a6d1fae640dffd2ba46765c25bf5359bc8edef242ff273c8bb810cf661d9609d38ef39c2eb6c2c96649b7a1ee79aa8a6db", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/83175b1ca88134a3e886c55f3b3c198031760b998f5cd961ff40f7d17a6e47529854c4d3d549d713536ad8b70bdbce68ec687821496c456ce289154703a3dcdc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/41c3f2861ab3d1a3b5c3e4449e6c9db01be4b9f183a17759d0a00b9f07ae28b29c9bda0b5449d0f52241ce665600a5bdb7a2582cf5021e391c3822a7cc620232", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/63d3e52270a4db91e4d3d6cb6936dae367c1233b9d87322a1fd37bbd47d882243986276dc92b2ed1fb4356acebd85f7a919eede9cdb97aaca98f148bec460d17"} build_url:https://queue.taskcluster.net/v1/task/KPQ0m4W3TPioLGtFx4ChlA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011191 build_url: 'https://queue.taskcluster.net/v1/task/KPQ0m4W3TPioLGtFx4ChlA/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/bdbee65a77f6549f53e6583793b574a6d1fae640dffd2ba46765c25bf5359bc8edef242ff273c8bb810cf661d9609d38ef39c2eb6c2c96649b7a1ee79aa8a6db", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/83175b1ca88134a3e886c55f3b3c198031760b998f5cd961ff40f7d17a6e47529854c4d3d549d713536ad8b70bdbce68ec687821496c456ce289154703a3dcdc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/41c3f2861ab3d1a3b5c3e4449e6c9db01be4b9f183a17759d0a00b9f07ae28b29c9bda0b5449d0f52241ce665600a5bdb7a2582cf5021e391c3822a7cc620232", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/63d3e52270a4db91e4d3d6cb6936dae367c1233b9d87322a1fd37bbd47d882243986276dc92b2ed1fb4356acebd85f7a919eede9cdb97aaca98f148bec460d17"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-11 04:47:05.352761) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-11 04:47:05.353166) ========= 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.AnjsRo7lbg/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.37BrffcNBB/Listeners TMPDIR=/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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.005075 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-11 04:47:05.402921) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-11 04:47:05.403336) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-11 04:47:05.403839) ========= ========= Total master_lag: 0.20 =========