builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0242 starttime: 1481113243.75 results: success (0) buildid: 20161207023139 builduid: 9970d6b8d8244a41a50344e0f848b62b revision: c401d72933641748f3738e90e7bbe539705e2f1c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-07 04:20:43.748403) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-07 04:20:43.748765) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-07 04:20:43.749046) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-07 04:20:43.900890) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 04:20:43.901179) ========= 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.qaajwuvpSI/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.ZTukW4cXNN/Listeners TMPDIR=/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-12-07 04:20:43-- 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% 8.15M=0.001s 2016-12-07 04:20:44 (8.15 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.162705 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 04:20:44.121153) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 04:20:44.121479) ========= 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.qaajwuvpSI/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.ZTukW4cXNN/Listeners TMPDIR=/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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.019420 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 04:20:44.214454) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-07 04:20:44.214804) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c401d72933641748f3738e90e7bbe539705e2f1c --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 c401d72933641748f3738e90e7bbe539705e2f1c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.qaajwuvpSI/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.ZTukW4cXNN/Listeners TMPDIR=/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-12-07 04:20:44,320 truncating revision to first 12 chars 2016-12-07 04:20:44,320 Setting DEBUG logging. 2016-12-07 04:20:44,320 attempt 1/10 2016-12-07 04:20:44,320 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c401d7293364?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-07 04:20:45,106 unpacking tar archive at: mozilla-central-c401d7293364/testing/mozharness/ program finished with exit code 0 elapsedTime=1.046308 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-07 04:20:45.285662) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-07 04:20:45.285948) ========= script_repo_revision: c401d72933641748f3738e90e7bbe539705e2f1c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-07 04:20:45.289375) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-07 04:20:45.289654) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-07 04:20:45.324121) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-12-07 04:20:45.324405) ========= /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.qaajwuvpSI/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.ZTukW4cXNN/Listeners TMPDIR=/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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:20:45 INFO - MultiFileLogger online at 20161207 04:20:45 in /builds/slave/test 04:20:45 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:20:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:20:45 INFO - {'append_to_log': False, 04:20:45 INFO - 'base_work_dir': '/builds/slave/test', 04:20:45 INFO - 'blob_upload_branch': 'Firefox', 04:20:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:20:45 INFO - 'branch': 'Firefox', 04:20:45 INFO - 'buildbot_json_path': 'buildprops.json', 04:20:45 INFO - 'config_files': ('talos/mac_config.py',), 04:20:45 INFO - 'default_actions': ('clobber', 04:20:45 INFO - 'read-buildbot-config', 04:20:45 INFO - 'download-and-extract', 04:20:45 INFO - 'populate-webroot', 04:20:45 INFO - 'create-virtualenv', 04:20:45 INFO - 'install', 04:20:45 INFO - 'run-tests'), 04:20:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:20:45 INFO - 'download_minidump_stackwalk': True, 04:20:45 INFO - 'download_symbols': 'ondemand', 04:20:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:20:45 INFO - 'tooltool.py': '/tools/tooltool.py', 04:20:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:20:45 INFO - '/tools/misc-python/virtualenv.py')}, 04:20:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:20:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:20:45 INFO - 'installer_path': 'installer.exe', 04:20:45 INFO - 'log_level': 'info', 04:20:45 INFO - 'log_name': 'talos', 04:20:45 INFO - 'log_to_console': True, 04:20:45 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:20:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:20:45 INFO - 'opt_config_files': (), 04:20:45 INFO - 'pip_index': False, 04:20:45 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:20:45 INFO - 'cmd': ('bash', 04:20:45 INFO - '-c', 04:20:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:20:45 INFO - 'enabled': True, 04:20:45 INFO - 'halt_on_failure': False, 04:20:45 INFO - 'name': 'check_screen_resolution'},), 04:20:45 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:20:45 INFO - 'cmd': ('bash', 04:20:45 INFO - '-c', 04:20:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:20:45 INFO - 'enabled': True, 04:20:45 INFO - 'halt_on_failure': False, 04:20:45 INFO - 'name': 'check_screen_resolution'},), 04:20:45 INFO - 'run_cmd_checks_enabled': True, 04:20:45 INFO - 'sps_profile': False, 04:20:45 INFO - 'sps_profile_interval': 0, 04:20:45 INFO - 'suite': 'dromaeojs-e10s', 04:20:45 INFO - 'system_bits': '32', 04:20:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:20:45 INFO - 'title': 't-yosemite-r7-0242', 04:20:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:20:45 INFO - 'use_talos_json': True, 04:20:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:20:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:20:45 INFO - 'work_dir': 'build'} 04:20:45 INFO - [mozharness: 2016-12-07 12:20:45.545580Z] Running clobber step. 04:20:45 INFO - Running pre-action listener: _resource_record_pre_action 04:20:45 INFO - Running main action method: clobber 04:20:45 INFO - rmtree: /builds/slave/test/build 04:20:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:20:46 INFO - Running post-action listener: _resource_record_post_action 04:20:46 INFO - [mozharness: 2016-12-07 12:20:46.560586Z] Finished clobber step (success) 04:20:46 INFO - [mozharness: 2016-12-07 12:20:46.560841Z] Running read-buildbot-config step. 04:20:46 INFO - Running pre-action listener: _resource_record_pre_action 04:20:46 INFO - Running main action method: read_buildbot_config 04:20:46 INFO - Using buildbot properties: 04:20:46 INFO - { 04:20:46 INFO - "project": "", 04:20:46 INFO - "product": "firefox", 04:20:46 INFO - "script_repo_revision": "production", 04:20:46 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 04:20:46 INFO - "repository": "", 04:20:46 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 04:20:46 INFO - "buildid": "20161207023139", 04:20:46 INFO - "pgo_build": "False", 04:20:46 INFO - "basedir": "/builds/slave/test", 04:20:46 INFO - "buildnumber": 37, 04:20:46 INFO - "slavename": "t-yosemite-r7-0242", 04:20:46 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 04:20:46 INFO - "platform": "yosemite_r7", 04:20:46 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:20:46 INFO - "branch": "mozilla-central", 04:20:46 INFO - "repo_path": "mozilla-central", 04:20:46 INFO - "revision": "c401d72933641748f3738e90e7bbe539705e2f1c", 04:20:46 INFO - "stage_platform": "macosx64", 04:20:46 INFO - "builduid": "9970d6b8d8244a41a50344e0f848b62b", 04:20:46 INFO - "slavebuilddir": "test" 04:20:46 INFO - } 04:20:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/fOK22v-9RLeWVpg8-HmZUw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 04:20:46 INFO - Running post-action listener: _resource_record_post_action 04:20:46 INFO - [mozharness: 2016-12-07 12:20:46.566584Z] Finished read-buildbot-config step (success) 04:20:46 INFO - [mozharness: 2016-12-07 12:20:46.566737Z] Running download-and-extract step. 04:20:46 INFO - Running pre-action listener: _resource_record_pre_action 04:20:46 INFO - Running main action method: download_and_extract 04:20:46 INFO - mkdir: /builds/slave/test/build/tests 04:20:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:46 INFO - trying https://queue.taskcluster.net/v1/task/fOK22v-9RLeWVpg8-HmZUw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 04:20:46 INFO - Downloading https://queue.taskcluster.net/v1/task/fOK22v-9RLeWVpg8-HmZUw/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:20:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fOK22v-9RLeWVpg8-HmZUw/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:20:47 INFO - Downloaded 1199 bytes. 04:20:47 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 04:20:47 INFO - Using the following test package requirements: 04:20:47 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 04:20:47 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:20:47 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 04:20:47 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:20:47 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 04:20:47 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:20:47 INFO - u'jsshell-mac.zip'], 04:20:47 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:20:47 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 04:20:47 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 04:20:47 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:20:47 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 04:20:47 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:20:47 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 04:20:47 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:20:47 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 04:20:47 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:20:47 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 04:20:47 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:20:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fOK22v-9RLeWVpg8-HmZUw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 04:20:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fOK22v-9RLeWVpg8-HmZUw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:20:47 INFO - Fetch https://queue.taskcluster.net/v1/task/fOK22v-9RLeWVpg8-HmZUw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 04:20:49 INFO - Expected file size: 16284235 04:20:49 INFO - Obtained file size: 16284235 04:20:55 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:20:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fOK22v-9RLeWVpg8-HmZUw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 04:20:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fOK22v-9RLeWVpg8-HmZUw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:20:55 INFO - Fetch https://queue.taskcluster.net/v1/task/fOK22v-9RLeWVpg8-HmZUw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 04:20:56 INFO - Expected file size: 16284235 04:20:56 INFO - Obtained file size: 16284235 04:21:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fOK22v-9RLeWVpg8-HmZUw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 04:21:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fOK22v-9RLeWVpg8-HmZUw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:21:02 INFO - Fetch https://queue.taskcluster.net/v1/task/fOK22v-9RLeWVpg8-HmZUw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 04:21:04 INFO - Expected file size: 14409734 04:21:04 INFO - Obtained file size: 14409734 04:21:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:21:04 INFO - trying https://queue.taskcluster.net/v1/task/fOK22v-9RLeWVpg8-HmZUw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 04:21:04 INFO - Downloading https://queue.taskcluster.net/v1/task/fOK22v-9RLeWVpg8-HmZUw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 04:21:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fOK22v-9RLeWVpg8-HmZUw/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:21:08 INFO - Downloaded 107591739 bytes. 04:21:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fOK22v-9RLeWVpg8-HmZUw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 04:21:08 INFO - mkdir: /builds/slave/test/properties 04:21:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:21:08 INFO - Writing to file /builds/slave/test/properties/build_url 04:21:08 INFO - Contents: 04:21:08 INFO - build_url:https://queue.taskcluster.net/v1/task/fOK22v-9RLeWVpg8-HmZUw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 04:21:09 INFO - Running post-action listener: _resource_record_post_action 04:21:09 INFO - Running post-action listener: set_extra_try_arguments 04:21:09 INFO - [mozharness: 2016-12-07 12:21:09.034350Z] Finished download-and-extract step (success) 04:21:09 INFO - [mozharness: 2016-12-07 12:21:09.034519Z] Running populate-webroot step. 04:21:09 INFO - Running pre-action listener: _resource_record_pre_action 04:21:09 INFO - Running main action method: populate_webroot 04:21:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:21:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:21:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:21:09 INFO - '--tppagecycles', 04:21:09 INFO - '7'], 04:21:09 INFO - 'tests': ['tsvgm']}}, 04:21:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:21:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:21:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:21:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:21:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:21:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:21:09 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:21:09 INFO - 'talos_options': ['--disable-e10s'], 04:21:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:21:09 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:21:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:21:09 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:21:09 INFO - 'talos_options': ['--disable-e10s'], 04:21:09 INFO - 'tests': ['damp', 'tps']}, 04:21:09 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:21:09 INFO - 'tests': ['damp', 'tps']}, 04:21:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:21:09 INFO - 'tests': ['dromaeo_dom']}, 04:21:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:21:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:21:09 INFO - 'tests': ['basic_compositor_video']}, 04:21:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:21:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:21:09 INFO - 'tests': ['a11yr', 04:21:09 INFO - 'ts_paint', 04:21:09 INFO - 'tpaint', 04:21:09 INFO - 'sessionrestore', 04:21:09 INFO - 'sessionrestore_no_auto_restore', 04:21:09 INFO - 'tabpaint']}, 04:21:09 INFO - 'other-e10s': {'tests': ['a11yr', 04:21:09 INFO - 'ts_paint', 04:21:09 INFO - 'tpaint', 04:21:09 INFO - 'sessionrestore', 04:21:09 INFO - 'sessionrestore_no_auto_restore', 04:21:09 INFO - 'tabpaint']}, 04:21:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:21:09 INFO - 'ts_paint', 04:21:09 INFO - 'tpaint', 04:21:09 INFO - 'sessionrestore', 04:21:09 INFO - 'sessionrestore_no_auto_restore', 04:21:09 INFO - 'tabpaint']}, 04:21:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:21:09 INFO - 'ts_paint', 04:21:09 INFO - 'tpaint', 04:21:09 INFO - 'sessionrestore', 04:21:09 INFO - 'sessionrestore_no_auto_restore', 04:21:09 INFO - 'tabpaint']}, 04:21:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:21:09 INFO - 'tests': ['a11yr', 04:21:09 INFO - 'ts_paint', 04:21:09 INFO - 'tpaint', 04:21:09 INFO - 'sessionrestore', 04:21:09 INFO - 'sessionrestore_no_auto_restore', 04:21:09 INFO - 'tabpaint']}, 04:21:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:21:09 INFO - 'tests': ['a11yr', 04:21:09 INFO - 'ts_paint', 04:21:09 INFO - 'tpaint', 04:21:09 INFO - 'sessionrestore', 04:21:09 INFO - 'sessionrestore_no_auto_restore', 04:21:09 INFO - 'tabpaint']}, 04:21:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:21:09 INFO - 'tests': ['tsvgx', 04:21:09 INFO - 'tsvgr_opacity', 04:21:09 INFO - 'tart', 04:21:09 INFO - 'tscrollx', 04:21:09 INFO - 'cart', 04:21:09 INFO - 'tsvg_static']}, 04:21:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:21:09 INFO - 'tsvgr_opacity', 04:21:09 INFO - 'tart', 04:21:09 INFO - 'tscrollx', 04:21:09 INFO - 'cart', 04:21:09 INFO - 'tsvg_static']}, 04:21:09 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:21:09 INFO - 'talos_options': ['--disable-e10s'], 04:21:09 INFO - 'tests': ['tp5o']}, 04:21:09 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:21:09 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:21:09 INFO - 'talos_options': ['--disable-e10s', 04:21:09 INFO - '--xperf_path', 04:21:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:21:09 INFO - 'tests': ['tp5n']}, 04:21:09 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:21:09 INFO - 'talos_options': ['--xperf_path', 04:21:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:21:09 INFO - 'tests': ['tp5n']}}, 04:21:09 INFO - 'talos.zip': {'path': '', 04:21:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:21:09 INFO - Running post-action listener: _resource_record_post_action 04:21:09 INFO - [mozharness: 2016-12-07 12:21:09.053756Z] Finished populate-webroot step (success) 04:21:09 INFO - [mozharness: 2016-12-07 12:21:09.053889Z] Running create-virtualenv step. 04:21:09 INFO - Running pre-action listener: _resource_record_pre_action 04:21:09 INFO - Running main action method: create_virtualenv 04:21:09 INFO - Creating virtualenv /builds/slave/test/build/venv 04:21:09 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:21:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:21:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:21:09 INFO - Using real prefix '/tools/python27' 04:21:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:21:09 INFO - Installing distribute.............................................................................................................................................................................................done. 04:21:12 INFO - Installing pip.................done. 04:21:12 INFO - Return code: 0 04:21:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:21:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:21:12 INFO - Reading from file tmpfile_stdout 04:21:12 INFO - Output received: 04:21:12 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:21:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:21:12 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:21:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:12 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:21:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:12 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 0x105e153f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d8b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7fa57f1d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c2ad30>, '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 0x105a91db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c22b20>, '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.qaajwuvpSI/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.ZTukW4cXNN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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:21:12 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:21:12 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:21:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qaajwuvpSI/Render', 04:21:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:21:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:21:12 INFO - 'HOME': '/Users/cltbld', 04:21:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:21:12 INFO - 'LOGNAME': 'cltbld', 04:21:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:12 INFO - 'MOZ_NO_REMOTE': '1', 04:21:12 INFO - 'NO_EM_RESTART': '1', 04:21:12 INFO - 'PAGER': '/bin/cat', 04:21:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:21:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:12 INFO - 'PWD': '/builds/slave/test', 04:21:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:21:12 INFO - 'SHELL': '/bin/bash', 04:21:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZTukW4cXNN/Listeners', 04:21:12 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 04:21:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:21:12 INFO - 'USER': 'cltbld', 04:21:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:21:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:21:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:12 INFO - 'XPC_FLAGS': '0x0', 04:21:12 INFO - 'XPC_SERVICE_NAME': '0', 04:21:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:21:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:13 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:21:13 INFO - Cleaning up... 04:21:13 INFO - Return code: 0 04:21:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:21:13 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:21:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:13 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:21:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:13 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 0x105e153f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d8b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7fa57f1d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c2ad30>, '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 0x105a91db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c22b20>, '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.qaajwuvpSI/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.ZTukW4cXNN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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:21:13 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:21:13 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:21:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qaajwuvpSI/Render', 04:21:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:21:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:21:13 INFO - 'HOME': '/Users/cltbld', 04:21:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:21:13 INFO - 'LOGNAME': 'cltbld', 04:21:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:13 INFO - 'MOZ_NO_REMOTE': '1', 04:21:13 INFO - 'NO_EM_RESTART': '1', 04:21:13 INFO - 'PAGER': '/bin/cat', 04:21:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:21:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:13 INFO - 'PWD': '/builds/slave/test', 04:21:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:21:13 INFO - 'SHELL': '/bin/bash', 04:21:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZTukW4cXNN/Listeners', 04:21:13 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 04:21:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:21:13 INFO - 'USER': 'cltbld', 04:21:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:21:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:21:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:13 INFO - 'XPC_FLAGS': '0x0', 04:21:13 INFO - 'XPC_SERVICE_NAME': '0', 04:21:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:21:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:13 INFO - Downloading/unpacking psutil>=3.1.1 04:21:13 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:21:13 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:21:13 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:21:13 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:21:13 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:21:13 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:21:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:21:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:21:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:21:17 INFO - Installing collected packages: psutil 04:21:17 INFO - Running setup.py install for psutil 04:21:17 INFO - building 'psutil._psutil_osx' extension 04:21:17 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:21:17 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:21:17 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:21:17 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:21:18 INFO - building 'psutil._psutil_posix' extension 04:21:18 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:21:18 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:21:18 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:21:18 INFO - ^ 04:21:18 INFO - 1 warning generated. 04:21:18 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:21:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:21:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:21:18 INFO - Successfully installed psutil 04:21:18 INFO - Cleaning up... 04:21:18 INFO - Return code: 0 04:21:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:21:18 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:21:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:18 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:21:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:18 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 0x105e153f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d8b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7fa57f1d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c2ad30>, '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 0x105a91db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c22b20>, '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.qaajwuvpSI/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.ZTukW4cXNN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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:21:18 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:21:18 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:21:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qaajwuvpSI/Render', 04:21:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:21:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:21:18 INFO - 'HOME': '/Users/cltbld', 04:21:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:21:18 INFO - 'LOGNAME': 'cltbld', 04:21:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:18 INFO - 'MOZ_NO_REMOTE': '1', 04:21:18 INFO - 'NO_EM_RESTART': '1', 04:21:18 INFO - 'PAGER': '/bin/cat', 04:21:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:21:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:18 INFO - 'PWD': '/builds/slave/test', 04:21:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:21:18 INFO - 'SHELL': '/bin/bash', 04:21:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZTukW4cXNN/Listeners', 04:21:18 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 04:21:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:21:18 INFO - 'USER': 'cltbld', 04:21:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:21:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:21:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:18 INFO - 'XPC_FLAGS': '0x0', 04:21:18 INFO - 'XPC_SERVICE_NAME': '0', 04:21:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:21:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:21:18 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:21:18 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:21:18 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:21:18 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:21:18 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:21:18 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:21:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:21:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:21:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:21:21 INFO - Installing collected packages: mozsystemmonitor 04:21:21 INFO - Running setup.py install for mozsystemmonitor 04:21:21 INFO - Successfully installed mozsystemmonitor 04:21:21 INFO - Cleaning up... 04:21:21 INFO - Return code: 0 04:21:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:21: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:21:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21: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:21:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:21 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 0x105e153f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d8b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7fa57f1d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c2ad30>, '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 0x105a91db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c22b20>, '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.qaajwuvpSI/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.ZTukW4cXNN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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:21:21 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:21:21 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:21:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qaajwuvpSI/Render', 04:21:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:21:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:21:21 INFO - 'HOME': '/Users/cltbld', 04:21:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:21:21 INFO - 'LOGNAME': 'cltbld', 04:21:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:21 INFO - 'MOZ_NO_REMOTE': '1', 04:21:21 INFO - 'NO_EM_RESTART': '1', 04:21:21 INFO - 'PAGER': '/bin/cat', 04:21:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:21:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:21 INFO - 'PWD': '/builds/slave/test', 04:21:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:21:21 INFO - 'SHELL': '/bin/bash', 04:21:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZTukW4cXNN/Listeners', 04:21:21 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 04:21:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:21:21 INFO - 'USER': 'cltbld', 04:21:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:21:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:21:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:21 INFO - 'XPC_FLAGS': '0x0', 04:21:21 INFO - 'XPC_SERVICE_NAME': '0', 04:21:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:21:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:21 INFO - Downloading/unpacking jsonschema==2.5.1 04:21:21 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:21:21 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:21:21 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:21:21 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:21:21 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:21:21 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:21:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:21:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:21:24 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:21:24 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:21:24 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:21:24 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:21:24 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:21:24 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:21:24 INFO - Downloading functools32-3.2.3-2.tar.gz 04:21:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:21:24 INFO - warning: no files found matching '*.txt' 04:21:24 INFO - no previously-included directories found matching 'build' 04:21:24 INFO - no previously-included directories found matching 'dist' 04:21:24 INFO - no previously-included directories found matching '.git*' 04:21:24 INFO - Installing collected packages: jsonschema, functools32 04:21:24 INFO - Running setup.py install for functools32 04:21:25 INFO - warning: no files found matching '*.txt' 04:21:25 INFO - no previously-included directories found matching 'build' 04:21:25 INFO - no previously-included directories found matching 'dist' 04:21:25 INFO - no previously-included directories found matching '.git*' 04:21:25 INFO - Successfully installed jsonschema functools32 04:21:25 INFO - Cleaning up... 04:21:25 INFO - Return code: 0 04:21:25 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:21:25 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:21:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:25 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:21:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:25 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 0x105e153f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d8b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7fa57f1d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c2ad30>, '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 0x105a91db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c22b20>, '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.qaajwuvpSI/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.ZTukW4cXNN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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:21:25 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:21:25 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:21:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qaajwuvpSI/Render', 04:21:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:21:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:21:25 INFO - 'HOME': '/Users/cltbld', 04:21:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:21:25 INFO - 'LOGNAME': 'cltbld', 04:21:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:25 INFO - 'MOZ_NO_REMOTE': '1', 04:21:25 INFO - 'NO_EM_RESTART': '1', 04:21:25 INFO - 'PAGER': '/bin/cat', 04:21:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:21:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:25 INFO - 'PWD': '/builds/slave/test', 04:21:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:21:25 INFO - 'SHELL': '/bin/bash', 04:21:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZTukW4cXNN/Listeners', 04:21:25 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 04:21:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:21:25 INFO - 'USER': 'cltbld', 04:21:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:21:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:21:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:25 INFO - 'XPC_FLAGS': '0x0', 04:21:25 INFO - 'XPC_SERVICE_NAME': '0', 04:21:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:21:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:25 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:21:25 INFO - Cleaning up... 04:21:25 INFO - Return code: 0 04:21:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:21:25 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:21:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:25 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:21:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:25 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 0x105e153f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d8b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7fa57f1d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c2ad30>, '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 0x105a91db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c22b20>, '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.qaajwuvpSI/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.ZTukW4cXNN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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:21:25 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:21:25 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:21:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qaajwuvpSI/Render', 04:21:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:21:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:21:25 INFO - 'HOME': '/Users/cltbld', 04:21:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:21:25 INFO - 'LOGNAME': 'cltbld', 04:21:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:25 INFO - 'MOZ_NO_REMOTE': '1', 04:21:25 INFO - 'NO_EM_RESTART': '1', 04:21:25 INFO - 'PAGER': '/bin/cat', 04:21:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:21:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:25 INFO - 'PWD': '/builds/slave/test', 04:21:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:21:25 INFO - 'SHELL': '/bin/bash', 04:21:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZTukW4cXNN/Listeners', 04:21:25 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 04:21:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:21:25 INFO - 'USER': 'cltbld', 04:21:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:21:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:21:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:25 INFO - 'XPC_FLAGS': '0x0', 04:21:25 INFO - 'XPC_SERVICE_NAME': '0', 04:21:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:21:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:25 INFO - Downloading/unpacking blobuploader==1.2.4 04:21:25 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:21:25 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:21:25 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:21:25 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:21:25 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:21:25 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:21:28 INFO - Downloading blobuploader-1.2.4.tar.gz 04:21:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:21:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:21:28 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:21:28 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:21:28 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:21:28 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:21:28 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:21:28 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:21:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:21:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:21:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:29 INFO - Downloading docopt-0.6.1.tar.gz 04:21:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:21:29 INFO - Installing collected packages: blobuploader, requests, docopt 04:21:29 INFO - Running setup.py install for blobuploader 04:21:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:21:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:21:29 INFO - Running setup.py install for requests 04:21:30 INFO - Running setup.py install for docopt 04:21:30 INFO - Successfully installed blobuploader requests docopt 04:21:30 INFO - Cleaning up... 04:21:30 INFO - Return code: 0 04:21:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:21: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:21:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21: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:21:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:30 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 0x105e153f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d8b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7fa57f1d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c2ad30>, '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 0x105a91db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c22b20>, '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.qaajwuvpSI/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.ZTukW4cXNN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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:21:30 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:21:30 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:21:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qaajwuvpSI/Render', 04:21:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:21:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:21:30 INFO - 'HOME': '/Users/cltbld', 04:21:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:21:30 INFO - 'LOGNAME': 'cltbld', 04:21:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:30 INFO - 'MOZ_NO_REMOTE': '1', 04:21:30 INFO - 'NO_EM_RESTART': '1', 04:21:30 INFO - 'PAGER': '/bin/cat', 04:21:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:21:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:30 INFO - 'PWD': '/builds/slave/test', 04:21:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:21:30 INFO - 'SHELL': '/bin/bash', 04:21:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZTukW4cXNN/Listeners', 04:21:30 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 04:21:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:21:30 INFO - 'USER': 'cltbld', 04:21:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:21:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:21:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:30 INFO - 'XPC_FLAGS': '0x0', 04:21:30 INFO - 'XPC_SERVICE_NAME': '0', 04:21:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:21:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:21:30 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-Y2e9IQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:21:30 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-w2b2kg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:21:30 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-cHIWIR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:21:31 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-mPKzlJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:21:31 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-eo3z_M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:21:31 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-DIsRjx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:21:31 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-9oi2aS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:21:31 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-oTphID-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:21:31 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-Ia1Vy9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:21:31 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-AFn18E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:21:31 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-mzLGGa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:21:31 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-4tHLor-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:21:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:21:32 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-TisWyn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:21:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:21:32 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-hnlxny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:21:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:21:32 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-QfqDfU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:21:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:21:32 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-_r7jNj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:21:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:21:32 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-1c5R6X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:21:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:21:32 INFO - Running setup.py install for manifestparser 04:21:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:21:32 INFO - Running setup.py install for mozcrash 04:21:32 INFO - Running setup.py install for mozdebug 04:21:32 INFO - Running setup.py install for mozdevice 04:21:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:21:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:21:33 INFO - Running setup.py install for mozfile 04:21:33 INFO - Running setup.py install for mozhttpd 04:21:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:21:33 INFO - Running setup.py install for mozinfo 04:21:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:21:33 INFO - Running setup.py install for mozInstall 04:21:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:21:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:21:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:21:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:21:33 INFO - Running setup.py install for mozleak 04:21:33 INFO - Running setup.py install for mozlog 04:21:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:21:34 INFO - Running setup.py install for moznetwork 04:21:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:21:34 INFO - Running setup.py install for mozprocess 04:21:34 INFO - Running setup.py install for mozprofile 04:21:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:21:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:21:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:21:34 INFO - Running setup.py install for mozrunner 04:21:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:21:34 INFO - Running setup.py install for mozscreenshot 04:21:34 INFO - Running setup.py install for moztest 04:21:34 INFO - Running setup.py install for mozversion 04:21:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:21:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:21:35 INFO - Cleaning up... 04:21:35 INFO - Return code: 0 04:21:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:21: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:21:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21: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:21:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:35 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 0x105e153f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d8b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7fa57f1d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c2ad30>, '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 0x105a91db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c22b20>, '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.qaajwuvpSI/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.ZTukW4cXNN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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:21:35 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:21:35 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:21:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qaajwuvpSI/Render', 04:21:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:21:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:21:35 INFO - 'HOME': '/Users/cltbld', 04:21:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:21:35 INFO - 'LOGNAME': 'cltbld', 04:21:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:35 INFO - 'MOZ_NO_REMOTE': '1', 04:21:35 INFO - 'NO_EM_RESTART': '1', 04:21:35 INFO - 'PAGER': '/bin/cat', 04:21:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:21:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:35 INFO - 'PWD': '/builds/slave/test', 04:21:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:21:35 INFO - 'SHELL': '/bin/bash', 04:21:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZTukW4cXNN/Listeners', 04:21:35 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 04:21:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:21:35 INFO - 'USER': 'cltbld', 04:21:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:21:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:21:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:35 INFO - 'XPC_FLAGS': '0x0', 04:21:35 INFO - 'XPC_SERVICE_NAME': '0', 04:21:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:21:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:21:35 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-maGhHB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:21:35 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:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:21:35 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-W1W4RN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:21:35 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:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:21:35 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-tgdyuI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:21:35 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:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:21:35 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-v1FSlp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:21:35 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:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:21:35 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-gvQ9f8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:21:35 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:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:21:35 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-EdbM_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:21:36 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:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:21:36 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-NHYjNU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:21:36 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:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:21:36 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-vuutHI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:21:36 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:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:21:36 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-ckQ8ok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:21:36 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:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:21:36 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-5U7SjU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:21:36 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:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:21:36 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-uRSEFH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:21:36 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:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:21:36 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-vNA1iW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:21:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:21:36 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-vxpskJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:21:36 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:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:21:36 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-sc8Q55-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:21:36 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:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:21:36 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-bL7qtN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:21:37 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:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:21:37 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-V3pZIt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:21:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:21:37 INFO - Running setup.py (path:/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/pip-5UVNyt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:21:37 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:21:37 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:21:37 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:21:37 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:21:37 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:21:37 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:21:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:21:37 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:21:37 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:21:37 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:21:37 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:21:37 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:21:37 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:21:39 INFO - Downloading blessings-1.6.tar.gz 04:21:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:21:39 INFO - Installing collected packages: blessings 04:21:39 INFO - Running setup.py install for blessings 04:21:40 INFO - Successfully installed blessings 04:21:40 INFO - Cleaning up... 04:21:40 INFO - Return code: 0 04:21:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:21:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:21:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:21:40 INFO - Reading from file tmpfile_stdout 04:21:40 INFO - Current package versions: 04:21:40 INFO - blessings == 1.6 04:21:40 INFO - blobuploader == 1.2.4 04:21:40 INFO - docopt == 0.6.1 04:21:40 INFO - functools32 == 3.2.3-2 04:21:40 INFO - jsonschema == 2.5.1 04:21:40 INFO - manifestparser == 1.1 04:21:40 INFO - mozInstall == 1.12 04:21:40 INFO - mozcrash == 1.0 04:21:40 INFO - mozdebug == 0.1 04:21:40 INFO - mozdevice == 0.49 04:21:40 INFO - mozfile == 1.2 04:21:40 INFO - mozhttpd == 0.7 04:21:40 INFO - mozinfo == 0.9 04:21:40 INFO - mozleak == 0.1 04:21:40 INFO - mozlog == 3.4 04:21:40 INFO - moznetwork == 0.27 04:21:40 INFO - mozprocess == 0.23 04:21:40 INFO - mozprofile == 0.28 04:21:40 INFO - mozrunner == 6.13 04:21:40 INFO - mozscreenshot == 0.1 04:21:40 INFO - mozsystemmonitor == 0.3 04:21:40 INFO - moztest == 0.7 04:21:40 INFO - mozversion == 1.4 04:21:40 INFO - psutil == 3.1.1 04:21:40 INFO - requests == 1.2.3 04:21:40 INFO - wsgiref == 0.1.2 04:21:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:21:40 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:21:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:40 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:21:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:40 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 0x105e153f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d8b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7fa57f1d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c2ad30>, '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 0x105a91db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c22b20>, '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.qaajwuvpSI/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.ZTukW4cXNN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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:21:40 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:21:40 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:21:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qaajwuvpSI/Render', 04:21:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:21:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:21:40 INFO - 'HOME': '/Users/cltbld', 04:21:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:21:40 INFO - 'LOGNAME': 'cltbld', 04:21:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:40 INFO - 'MOZ_NO_REMOTE': '1', 04:21:40 INFO - 'NO_EM_RESTART': '1', 04:21:40 INFO - 'PAGER': '/bin/cat', 04:21:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:21:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:40 INFO - 'PWD': '/builds/slave/test', 04:21:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:21:40 INFO - 'SHELL': '/bin/bash', 04:21:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZTukW4cXNN/Listeners', 04:21:40 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 04:21:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:21:40 INFO - 'USER': 'cltbld', 04:21:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:21:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:21:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:40 INFO - 'XPC_FLAGS': '0x0', 04:21:40 INFO - 'XPC_SERVICE_NAME': '0', 04:21:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:21:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:40 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:21:40 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:21:40 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:21:40 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:21:40 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:21:40 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:21:40 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:21:40 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:21:40 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:21:40 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:21:40 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:21:40 INFO - Cleaning up... 04:21:40 INFO - Return code: 0 04:21:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:21:40 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:21:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:40 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:21:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:40 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 0x105e153f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d8b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7fa57f1d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105c2ad30>, '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 0x105a91db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c22b20>, '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.qaajwuvpSI/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.ZTukW4cXNN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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:21:40 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:21:40 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:21:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qaajwuvpSI/Render', 04:21:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:21:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:21:40 INFO - 'HOME': '/Users/cltbld', 04:21:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:21:40 INFO - 'LOGNAME': 'cltbld', 04:21:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:40 INFO - 'MOZ_NO_REMOTE': '1', 04:21:40 INFO - 'NO_EM_RESTART': '1', 04:21:40 INFO - 'PAGER': '/bin/cat', 04:21:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:21:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:40 INFO - 'PWD': '/builds/slave/test', 04:21:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:21:40 INFO - 'SHELL': '/bin/bash', 04:21:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZTukW4cXNN/Listeners', 04:21:40 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 04:21:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:21:40 INFO - 'USER': 'cltbld', 04:21:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:21:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:21:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:40 INFO - 'XPC_FLAGS': '0x0', 04:21:40 INFO - 'XPC_SERVICE_NAME': '0', 04:21:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:21:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:21:41 INFO - Cleaning up... 04:21:41 INFO - Return code: 0 04:21:41 INFO - Running post-action listener: _resource_record_post_action 04:21:41 INFO - Running post-action listener: _start_resource_monitoring 04:21:41 INFO - Starting resource monitoring. 04:21:41 INFO - [mozharness: 2016-12-07 12:21:41.068729Z] Finished create-virtualenv step (success) 04:21:41 INFO - [mozharness: 2016-12-07 12:21:41.069582Z] Running install step. 04:21:41 INFO - Running pre-action listener: _resource_record_pre_action 04:21:41 INFO - Running main action method: install 04:21:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:21:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:21:41 INFO - Reading from file tmpfile_stdout 04:21:41 INFO - Detecting whether we're running mozinstall >=1.0... 04:21:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:21:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:21:41 INFO - Reading from file tmpfile_stdout 04:21:41 INFO - Output received: 04:21:41 INFO - Usage: mozinstall [options] installer 04:21:41 INFO - Options: 04:21:41 INFO - -h, --help show this help message and exit 04:21:41 INFO - -d DEST, --destination=DEST 04:21:41 INFO - Directory to install application into. [default: 04:21:41 INFO - "/builds/slave/test"] 04:21:41 INFO - --app=APP Application being installed. [default: firefox] 04:21:41 INFO - mkdir: /builds/slave/test/build/application 04:21:41 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:21:41 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:22:14 INFO - Reading from file tmpfile_stdout 04:22:14 INFO - Output received: 04:22:14 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:22:14 INFO - Running post-action listener: _resource_record_post_action 04:22:14 INFO - [mozharness: 2016-12-07 12:22:14.169959Z] Finished install step (success) 04:22:14 INFO - [mozharness: 2016-12-07 12:22:14.170116Z] Running run-tests step. 04:22:14 INFO - Running pre-action listener: _resource_record_pre_action 04:22:14 INFO - Running main action method: run_tests 04:22:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:22:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:22:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:22:14 INFO - 2016-12-07 04:22:14.184 screenresolution[2177:16764] starting screenresolution argv=screenresolution get 04:22:14 INFO - 2016-12-07 04:22:14.187 screenresolution[2177:16764] Display 0: 1600x1200x32@60 04:22:14 INFO - 2016-12-07 04:22:14.194 screenresolution[2178:16766] starting screenresolution argv=screenresolution list 04:22:14 INFO - Available Modes on Display 0 04:22:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:22:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:22:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:22:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:22:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:22:14 INFO - Intel Iris: 04:22:14 INFO - Chipset Model: Intel Iris 04:22:14 INFO - Type: GPU 04:22:14 INFO - Bus: Built-In 04:22:14 INFO - VRAM (Dynamic, Max): 1536 MB 04:22:14 INFO - Vendor: Intel (0x8086) 04:22:14 INFO - Device ID: 0x0a2e 04:22:14 INFO - Revision ID: 0x0009 04:22:14 INFO - Displays: 04:22:14 INFO - Display: 04:22:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:22:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:22:14 INFO - Display Serial Number: 1600x1200 60 04:22:14 INFO - Main Display: Yes 04:22:14 INFO - Mirror: Off 04:22:14 INFO - Online: Yes 04:22:14 INFO - Rotation: Supported 04:22:14 INFO - Return code: 0 04:22:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:22:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:22:14 INFO - Python 2.7.3 04:22:14 INFO - Return code: 0 04:22:14 INFO - grabbing minidump binary from tooltool 04:22:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:22:14 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 0x105c2ad30>, '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 0x105a91db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105c22b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:22:14 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:22:14 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:22:14 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:22:14 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:22:14 INFO - Return code: 0 04:22:14 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:22:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:22:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:22:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:22:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:22:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fOK22v-9RLeWVpg8-HmZUw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0242', '--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:22:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fOK22v-9RLeWVpg8-HmZUw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0242 --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:22:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qaajwuvpSI/Render', 04:22:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:22:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:22:14 INFO - 'HOME': '/Users/cltbld', 04:22:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:22:14 INFO - 'LOGNAME': 'cltbld', 04:22:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:22:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:22:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:14 INFO - 'MOZ_NO_REMOTE': '1', 04:22:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:22:14 INFO - 'NO_EM_RESTART': '1', 04:22:14 INFO - 'PAGER': '/bin/cat', 04:22:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:22:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:14 INFO - 'PWD': '/builds/slave/test', 04:22:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:22:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:22:14 INFO - 'SHELL': '/bin/bash', 04:22:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZTukW4cXNN/Listeners', 04:22:14 INFO - 'TMPDIR': '/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/', 04:22:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:22:14 INFO - 'USER': 'cltbld', 04:22:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:22:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:22:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:14 INFO - 'XPC_FLAGS': '0x0', 04:22:14 INFO - 'XPC_SERVICE_NAME': '0', 04:22:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:22:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fOK22v-9RLeWVpg8-HmZUw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0242', '--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:22:14 INFO - mozversion application_buildid: 20161207023139 04:22:14 INFO - mozversion application_changeset: c401d72933641748f3738e90e7bbe539705e2f1c 04:22:14 INFO - mozversion application_display_name: Nightly 04:22:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:22:14 INFO - mozversion application_name: Firefox 04:22:14 INFO - mozversion application_remotingname: firefox 04:22:14 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:22:14 INFO - mozversion application_vendor: Mozilla 04:22:14 INFO - mozversion application_version: 53.0a1 04:22:14 INFO - mozversion platform_buildid: 20161207023139 04:22:14 INFO - mozversion platform_changeset: c401d72933641748f3738e90e7bbe539705e2f1c 04:22:14 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:22:14 INFO - mozversion platform_version: 53.0a1 04:22:14 INFO - using testdate: 1481113334 04:22:14 INFO - actual date: 1481113334 04:22:14 INFO - starting webserver on 'localhost:49503' 04:22:14 INFO - SUITE-START | Running 2 tests 04:22:14 INFO - TEST-START | dromaeo_css 04:22:14 INFO - operating with platform_type : mac_ 04:22:14 INFO - Initialising browser for dromaeo_css test... 04:22:14 INFO - TEST-INFO | started process 2188 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/tmp9_2Pse/profile http://localhost:49503/getInfo.html) 04:22:17 INFO - PROCESS | 2188 | 2016-12-07 04:22:17.899 plugin-container[2190:16933] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x904f, name = 'com.apple.tsm.portname' 04:22:17 INFO - PROCESS | 2188 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:22:17 INFO - PROCESS | 2188 | 2016-12-07 04:22:17.903 plugin-container[2190:16933] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4a0b, name = 'com.apple.CFPasteboardClient' 04:22:17 INFO - PROCESS | 2188 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:22:17 INFO - PROCESS | 2188 | 2016-12-07 04:22:17.903 plugin-container[2190:16933] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:22:17 INFO - PROCESS | 2188 | __metrics Screen width/height:1600/1200 04:22:17 INFO - PROCESS | 2188 | colorDepth:24 04:22:17 INFO - PROCESS | 2188 | Browser inner width/height: 1024/689 04:22:17 INFO - PROCESS | 2188 | __metrics 04:22:18 ERROR - PROCESS | 2188 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3220: TypeError: this.tabs is undefined 04:22:18 INFO - TEST-INFO | 2188: exit 0 04:22:18 INFO - Browser initialized. 04:22:18 INFO - Running cycle 1/1 for dromaeo_css test... 04:22:18 INFO - TEST-INFO | started process 2191 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/tmp9_2Pse/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:22:21 INFO - PROCESS | 2191 | 2016-12-07 04:22:21.661 plugin-container[2192:17055] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x873f, name = 'com.apple.tsm.portname' 04:22:21 INFO - PROCESS | 2191 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:22:21 INFO - PROCESS | 2191 | 2016-12-07 04:22:21.662 plugin-container[2192:17055] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c0b, name = 'com.apple.CFPasteboardClient' 04:22:21 INFO - PROCESS | 2191 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:22:21 INFO - PROCESS | 2191 | 2016-12-07 04:22:21.662 plugin-container[2192:17055] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:22:31 INFO - PROCESS | 2191 | RSS: Main: 241717248 04:22:31 INFO - PROCESS | 2191 | 04:23:20 INFO - PROCESS | 2191 | 1481113400911 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:25:34 INFO - PROCESS | 2191 | Cycle 1(1): loaded http://localhost:49503/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49503/tests/dromaeo/cssquery-ext.html) 04:25:37 INFO - PROCESS | 2191 | RSS: Main: 250425344 04:25:37 INFO - PROCESS | 2191 | 04:28:39 INFO - PROCESS | 2191 | Cycle 1(1): loaded http://localhost:49503/tests/dromaeo/cssquery-ext.html (next: http://localhost:49503/tests/dromaeo/cssquery-jquery.html) 04:28:40 INFO - PROCESS | 2191 | RSS: Main: 261496832 04:28:40 INFO - PROCESS | 2191 | 04:31:42 INFO - PROCESS | 2191 | Cycle 1(1): loaded http://localhost:49503/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49503/tests/dromaeo/cssquery-mootools.html) 04:31:42 INFO - PROCESS | 2191 | RSS: Main: 267698176 04:31:42 INFO - PROCESS | 2191 | 04:34:44 INFO - PROCESS | 2191 | Cycle 1(1): loaded http://localhost:49503/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49503/tests/dromaeo/cssquery-prototype.html) 04:34:45 INFO - PROCESS | 2191 | RSS: Main: 266502144 04:34:45 INFO - PROCESS | 2191 | 04:37:48 INFO - PROCESS | 2191 | Cycle 1(1): loaded http://localhost:49503/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49503/tests/dromaeo/cssquery-yui.html) 04:37:48 INFO - PROCESS | 2191 | RSS: Main: 271216640 04:37:48 INFO - PROCESS | 2191 | 04:40:51 INFO - PROCESS | 2191 | Cycle 1(1): loaded http://localhost:49503/tests/dromaeo/cssquery-yui.html (next: http://localhost:49503/tests/dromaeo/cssquery-dojo.html) 04:40:51 INFO - PROCESS | 2191 | RSS: Main: 274108416 04:40:51 INFO - PROCESS | 2191 | 04:40:51 INFO - PROCESS | 2191 | __start_tp_report 04:40:51 INFO - PROCESS | 2191 | _x_x_mozilla_page_load 04:40:51 INFO - PROCESS | 2191 | _x_x_mozilla_page_load_details 04:40:51 INFO - PROCESS | 2191 | |i|pagename|runs| 04:40:51 INFO - PROCESS | 2191 | |0;dojo.html;3361.2437201629623;3375.1562109472634;3403.3023230237804;3411.1472131967007;3443;4989.77750451139;5592.3009623797025;5624.3531993820725;5635.915461268084;5636.408177141398;5608.355039170497;5726.226959360485;5728;5759.222504961829;5760.798372056979;5150.974245128769;5161.122609156452;5166.638335316529;5258.079836028699;5389.299391079154;5257.080010998079;5263.6578622389425;5264.684118952875;5266.157414813631;5277.973610131944;4360.934585981213;4365.738055716652;5116.565091967187;5298.867528311785;5349.384820745625;5166.225066240057;5271.28837606922;5304.946950530522;5327.280817089721;5330.7068111253675;5062.594992400599;5121.923171152435;5133.794648214067;5157.277981082651;5241.0828105081455;4596.632269418438;4780.235162374038;5731.254936858223;5739.885202295973;5841.707914604295;4803;6266.78066267683;6267.2165979252595;6268.529860260499;6301.369863013662;6161.599496032743;6171.691415429211;6171.722272497748;6198.946179149555;6286.151369565142;5876.794312199053;5885.352611212763;5902.6458412495385;5914.142449344864;5954.583179177459;6273.027680709497;6342.143810585604;6352.174217351807;6359.236891573041;6369.490440764727;5962.850928726816;6025.457708806229;6102.72537735803;6136.018237082046;6142.9864072427545;6116.244470650255;6172.8765424691255;6203.8138855834395;6219.937800621936;6268.404501572343;6156.322804491502;6170.352113028068;6173.9073913891325;6198;6205.131281620576;5033.697978121251;6066.120412540157;6107.541934354941;6141.6007959482495;6198.690065496708;4934.383202099738;4976.178930476503;4978.054169707744;4985.825496107619;4990.251462280687;4447.844325448594;4448;4475.104979004147;4486.887827804331;4536.251518499411;5419;5754.712264386764;5775;5795.768169273266;5940.138679891392;6226.813195604139;6227.346128656516;6237.033259844731;6262.029385445263;6287.182666253358;4940.7035577865445;5894.616849904743;5898.675572843535;5908.438698323653;5947.970260148758;5420.783168673288;5427.864303392446;5436.809711660073;5437.265969094122;5468.234447177399;6146.555559443527;6243.188385509855;6292.905606415816;6323.652199129092;6364.299927008118;6208.534359923115;6251.218597675291;6266.248050234001;6275.905861412174;6291.119243306032;6345.650989195638;6395.776147834804;6407.743690252524;6414.390632889868;6428.453581445442;5121.539061484485;6076.574639775174;6103.761967187164;6109.6475967989745;6121.632702037892;5239.187925871496;6257.2491301044165;6259.186305780219;6263.3736626337;6271.090691849748;6120.051392034242;6153.169322141453;6168.907466388097;6178.536609754196;6181;5991.610545314541;6045.455908968214;6098.5426093042315;6108.389161083856;6188.597741146991;5807.883842323045;5869.647821130746;5941.435563621449;5966.49284810796;5986.311574169026;6101.974255744646;6102.9694851525455;6107.053406721965;6119.2350956130485;6123.770712314271;4783.784729687242;5921.6743079131065;5936.7922122725495;5984.700764961822;6077.4226448487325 04:40:51 INFO - PROCESS | 2191 | |1;ext.html;448.63660435047603;470.6046920586709;475.28706939590614;517.3403910014729;524.2450870746126;29401.705982940166;30585.84707076464;39165.80417097911;40221.994450138685;40223.994400140014;38656.42015369765;39077.609223907755;39087.80456097716;39139.41290880639;39195.82412527622;9217.907820921806;9412.152906238438;9420.481873496956;9435.528223588793;9438.480883551401;8439.915600843975;8601.354898382615;9267.72196834096;10960.506777195005;11205.047570956438;11212.943935280313;11318.20772545922;11321.981021708045;11328.886711132865;11342.206045576813;9344.205742511895;11210;11241.381724005176;11243.988041076342;11252.887471125267;11028.669139925814;11099.944500277528;11109.00018998286;11110.388928608923;11125.276857004268;37577.62422375769;37677.246455070745;37810.43284350709;37811;37836.62163378359;2624.448865738178;3465.6187819339852;3470.236547959445;3689.1883785567134;3894.7078969077434;28593.85703071492;28619.427611447863;29277.97527086563;29308.56037159444;29448.852755736083;2707.2690373599016;3149.811011339327;3165.7309128724087;3211.2935154266024;3312.4700047992205;467854;469247;470145;470228;475635;53726.731366342916;54534.45465545373;54602.45397546053;54701.179482307794;54732.452675472734;56598;56727.71636141793;56917.43082569204;57056.714716426155;57090.714546427;14671.77992330116;14982.026168299026;15147.54557363281;15164.545063648107;15165.483451654747;11729.589464368706;11917.463714132884;11950.940245298718;11973;11989.940050299692;12833.294168820617;13090.476380944847;14243.359048842827;14680.706385872436;14684.559463216121;5389.83830485086;5568.276124103841;5724.282715185428;5837.182794408786;6506.902396464056;833.5707110837923;840.5671079394117;858.9570521473902;958.6021800952666;968.162539403411;27245;27842.72157278442;28962.565561516592;29180.416391672046;29331.413371732448;907.6641642592283;1002.7515742900137;1024.6721049264313;1063.9148868090533;1131.4682099413262;11826.5860694877;14638.48765293231;14871.851281487046;14908.105513668997;15552.222388880737;569243;578437;580641;584801;585979;51064.489355106714;52423.95152096936;52536.47463525392;52691.73654131705;52834.207486887724;1291.922484650924;1332.3404914567157;1335.599320203935;1345.8855997240148;1351.86481351866;26749.598756018288;28584.83221208509;28627;29149.85425072861;29222;45931;46070;46414;46436;46567.83580410517;562227;563201;563478;563665;564514;36616.81691591525;37417.43873841949;37650.893649258775;37933.103344832096;38041;42932.78533607312;43071.56928430801;43245.35131973086;44125;44509;36286;36425.635743642226;36536.634633653324;37644.2471150581;37879;31370.05889823309;35465.29069418545;36485;37068.07329816668;37236.44145337768;35221.29557408889;35713.64286357103;36307.636923631486;36442.54229830883;36500.63499364972;27022.594661079707;28511.572326414705;31553.842230788698;32475.18812029718;33061.84283550064;20560.28039018627;20978.2657606983;24014;24735;25110.49779004446 04:40:51 INFO - PROCESS | 2191 | |2;jquery.html;332.5377724962302;367.29479399552855;371.2630428599231;377.63369531554383;398.00300247879056;18976.905115474405;19031.904840475778;19140;19360.128794204258;19472.610547789052;19052.618947621075;19520.535959803;19630.509237269074;19853.801461985375;19997.800021999774;5504.284443022421;5559.3328800543995;5806.709664516758;5808.070708686611;5829.970850145764;5524.475174858402;5699.68651724155;5703.287089113861;5704.572157088214;5707.258056452676;5431.456854314557;5601.747921343549;5662.320521537421;5675.063614503602;5686.715664216773;4866.732329721864;5561.694106824123;5562.749676264578;5616.213730077792;5636.15457681347;4926.729029903354;4950.2822090796635;4955.207166853323;4971.552560269557;5165.66423182492;12565;12703.682407939783;12770;12775.425105870258;12779.488820447172;2119.3535971528677;2181.073043956328;2260.7174103237094;2457.2751038443525;2622.645942797717;9586.856197157049;9629.951850240774;9765.414075155513;10131.544080516394;10209.795804083877;1818.8272114149136;1885.58517126232;1889.9244030238774;1902.3056584346614;1907.8759880607715;113700;116933;117234;117713;118078;9023.458592484472;11227.494762735696;11446.713832154262;11491.77016459666;11659.708507287385;14111.364988575539;14188.64528386778;14197;14199.716005680035;14230.2173380463;7994.5203287802915;8070.556119413372;8146.75559733209;8287.917120828835;8306.127856575093;6160.44555989963;7917.960410197912;8000.119986801447;8145.144759800254;8166.265036146775;4364.476262848415;4469.08383781324;4473.105378924228;4552.886177845514;4558.635309175258;1875.2124107874724;1924.5381108533852;1925.1529327096032;1927.922883084661;1933.1494142577221;802.4623502253504;830.8130670599066;885.3183049052323;917.1195652173988;963.9084286992725;15182.620434489227;19673.311434099738;20759.377218683465;20905;20931;898.3711402018613;904.7150147703452;911.480456140007;922.4004397141912;943.32080901752;8010.919890801018;10403.9308404021;10882.836757448644;10922.836157457645;10935.56257749681;449553;450548;454495;536359.9546006813;537496;93653.5317323409;128936.3553182228;131308;134338.61137637327;140314;931.1759093202564;989.0455710239653;995.1541189988596;1000.25980774228;1004.2417974429259;16044.037357758572;17767.289308427517;18297.45107646773;18515.72226416578;18968.051597420348;43177.56822431736;54533;55710.16434753563;56270;56522.434775651716;79261.8110728351;79482.80775788483;80162;80580;81950.59024705077;6208.348123447154;7746.559833652382;7864.764057078297;7930.325922296439;8146.877796832934;11378.203525753117;12144.757104857677;12438.689032774253;12480.812787808372;12585.307808070644;8679.609417576097;10464.63373781914;10592.205584581034;10804.837927431252;10814;10548.103411210133;10570.41862697559;10752.139828813833;10803.758872338425;10958.890411095786;8860.468371897707;10129.139023183112;10597.15222782191;10791.838122428013;11161.386123763272;7715.3441957432005;7745.573993430416;7894.881576776468;7895.605219738875;8127.634256458356;7917.564533950457;9408.341416100808;10454.947725261325;10501.78996420052;10724.088452481314 04:40:51 INFO - PROCESS | 2191 | |3;mootools.html;1456.1772598481857;1465.904716193447;1661.6759731852287;1763.2329936477624;1817.9272829086838;7443.59060251686;7708.653110610022;7946.76159715208;8295.17048295171;8353.958230208847;7887.053553573579;8150.3887208459455;8195.22145396188;8245.958770206156;8284.83430331393;2254.6843441918104;2274.613315736329;2281.543691261746;2285.371522831218;2285.531466049464;2297.8621282723007;2312.1791763923816;2322.0595658758148;2330.4406942333803;2337.4039619896903;2269.103704036904;2271.5343354612264;2300.9309720708407;2302.4128847143957;2309.84985975911;1735.7656716343258;1957.9916343083323;1967.6064787042649;2231.520223152022;2249.1902914950606;1943.2615606069744;2278.5215104828007;2305.250793492122;2313.306008197534;2315.6642286868478;8200.01599808027;8231.506109633441;8238.546879921601;8306.169383061706;8330.958345208235;4965.478624744386;5076.923846142311;5129.7435128243815;5145.125328694131;5149.0474262261605;2991.2073300575366;3195.408849362875;3269.4171604432468;3503.8248087595516;3518.1204698825295;1013.1084645511976;1025.6307729217551;1069.7860427914447;1083.3391631105019;1083.7236504691332;10295.79408411835;10398.68803935883;10454.79090418195;10527.263091583593;10745.194110441747;4471.5081341052455;4479.977600111979;4614.561616646413;4616.030633566921;4651.930221046687;9370.765730856783;9444.574994125282;9444.763880902896;9452.8582071269;9474;5125.359330083739;5167.328247327899;5173.301604283373;5187.377514698261;5202.583793296527;3885.3783394657285;4119.938200926988;4734.100520901018;4741;4751.216049351819;3711.814409279579;3735.860562528455;3845.0964023454467;3868.516435445569;3870.845166193377;1239.9318037507844;1273.4969686973593;1275.2858399296238;1283.2300619628336;1290.3096843188848;774.2257742257742;799.8240387114826;851.9701810436605;870.1298701298701;874.5670892908051;5076.7207803571155;5296.205569164579;5368.838934831883;5688.288963879515;5818.796342128006;852.3735054734765;871.3595507302127;876.5047748022347;900.4777229207044;901.8647202919483;3653.6116275815552;3662.5788034376387;3729.160938788805;3760.9247815043545;3856.9614303857165;9464.95267523658;9725.027497250217;9898.505074746234;9910;9963.452010139512;9757.560909759079;9828.754281142885;9857.457839818735;9874.654387096562;9881.901180988241;7233.891491627524;7481.21447248042;7572.091349038151;7665.233476652402;7683.346915512244;5209.114450543492;5617.43825617435;5622.2128901954575;5682.516986056232;5690.487856092972;9114.589843457194;9204.907950920406;9273.258139348702;9292.814143716952;9350.953245234003;9176.908230917605;9280.767980800534;9312.394694344846;9334.27315946552;9393.013733557878;6547.9672601636685;6768.695408706521;7059.5764254144915;7162;7172.784816455514;7557.319841214317;7750;7796.84406311882;7924.167962363868;7950.522968621901;6979.720811167699;7115.003899453977;7143.892841607276;7167.641617918979;7249.601271929883;6983.790486285419;7055.435565154878;7072.25741297177;7093.467989900675;7123.536970096927;6346.365363463617;6494.772682956074;6583.144191255106;6626.2379826318665;6636.170478690164;4770.570648641639;4823.131836269506;4832.806687732451;4873.610111191168;4879.756012199447;4727.858164255078;4814.614830813456;4815.22956326986;4889.682170658896;4976.850694479172 04:40:51 INFO - PROCESS | 2191 | |4;prototype.html;259.95320842248395;296.73886979458075;311.2343634658739;315.6653946816375;316.2378667411536;4290.678199135062;4576.656750743695;5332.893342133165;5424.755885985135;5489.709918169227;3979.9403008954887;4846.39420072491;5340.599455040868;5396.839679468913;5398.245570189684;3413.5221069050353;3429.657034296563;3953.782541960191;4151.107511884937;4165.666746660275;3599.1541987632886;3715.535558055243;3924.8822535323843;4055.2295063937904;4207.747535147885;4068.41008053832;4094.7133700640966;4120.876373708794;4126;4144.564820693829;3405.5062016007787;3511.17487390463;4019.97990010051;4113.753174809506;4170.0817623893045;2869.5552189410673;3114.345987342661;3583.33708263972;3597.4963505109304;3601.1717305019993;3960.4059391091278;5044.646874718771;5236.329471969285;5244.108501554745;5267.973660131714;4133.379993001044;4688.765561721901;4697.271922851964;4708.717476951394;4710.717356958559;4560.247559152735;4999.200127979542;5384.838454846361;5707.34365547959;5718.48533631971;3679.589868636021;3915.8042097895277;3940.211957608461;3956.347202711549;3969.98015009926;4848.903021939576;4935.544014515726;5722.742476588522;5924.940750592482;5945.910811337833;3598.5425902509523;3782.7730336179366;3885.611438856092;4006.8998275042773;4010.979945100256;3763.6989040876665;3934.0361611405388;4025.611164148364;4064.4106604542767;4079.571644977294;4143.129942712064;4231.936520952188;4555.790441635804;4596.747178905192;4656.697314674535;4443.200223959719;5412.512873841373;5807.332156802022;5822.302837698092;5867.589268751147;1136.9204155709187;1141.7088642396136;1240.5782034108265;1273.1475702852329;1300.674831292177;863.1497974495118;879.4591326334386;889.8798662180652;891.4072142025481;892.0143241717808;4576.405067341224;5035.672681275705;5175.972056347004;5243.895122097613;5279.551238144724;4421.9336709949375;5240.213967904845;5281.943611277683;5586.636868603528;5781.82654520365;5018.2974383586325;5537.390887002426;5562.802692936268;5565.158312268352;5595.776168953278;2476.1209770531564;2899.7970142089853;2976.866041028159;2995.955060674092;3041.7718671099756;5360.035193665178;5501.889962200734;5921.851953701106;6170.444659980623;6230.408111229426;5109.795608175706;6174.845628859314;6175.5677102602385;6191.721372538246;6233.283172435137;4962.206047032458;6188.8762224755255;6217.875642487215;6257.2804127525915;6312.936870631327;5315.734213289397;5429.782808687608;5772.509336706427;6057.636541807506;6067.817965461043;5878.911816322673;5961.791337303173;5973.432523910222;6000.579669588293;6112.663803490673;5515.586331025109;5727.422659803022;5824.330202026821;6206.410391012847;6332.461740752087;3959.544652365015;4019.718619696593;4021.235965166609;4022.798860057044;4027.697922655754;5343.4389389113585;5420.7289635518855;6151.661658608819;6172.351903050115;6201.720922558406;4694.108119457293;5649.435056494318;5859.1875899569295;5875.941240587539;5895.578316262803;5900.43945825146;5912.70436478183;5928.687811753506;5932.377100404568;5934.732937017931;4878.682885612424;5515.669059856422;5524.370310758256;5550.531821883261;5672.546196304368;5855.677937713296;5893.70531473416;5907.734151963086;5913.91129133072;5934.219734079845;5482.945170548243;5558.360788509373;5655.802046928337;5784.2769653793275;5810.01229790945 04:40:51 INFO - PROCESS | 2191 | |5;yui.html;684.3601232847285;713.828681116532;734.9412047036237;741.7107328142025;809.1706001348617;15007.624809379771;15241.466548670798;15841.207939603031;15902.44341448051;15919.522414327574;14014.789778153336;14247.572572822806;14284.500042498514;14304.713905721905;14312.928435357835;642.4314481683721;659.4032400677371;807.1887752808449;820.0282665041915;822.5311572403732;784.2862994674847;814.8981377327834;833.7332053742805;839.0560619303284;840.4159109418956;865.671045002898;869.7303835810887;869.7955980344614;870.0907551608552;870.3776799588293;853.7865533616596;856.1695155698962;861.8621020636731;864.1833467373366;866.06032454786;642.7364780440043;642.8521440068811;643.6492111799081;644.4135836388864;646.2761706888315;14393.280335983263;14762.926185369004;14765.77851332231;14832.925835370863;15130.773038404433;14082.366293516714;14538.636534086627;14586.92706536471;14681.412743490248;14754.188519631416;11574.537018519333;11873.821892671616;11912.702182445422;11918.761624767543;12183.817242741366;3682.4844521766972;3686.870959516404;3718.2377612589353;3750.1749615084636;3816.790076545789;114361.4281928585;118070.40964795121;119104;120973;121068;10891.694722237498;10896.509657065451;11008.339499630049;11056.336619802838;11210.43947802623;19537.316193933144;20450.181992720423;20531.178752850017;21139.577208455743;22670.773292266866;7538.472306938571;7544.735934242275;7662.961685191538;7733.806654833674;7856.410769192334;4317.988128522963;4419.445958669917;4426.114777044604;4477.306017567283;4510.075434535912;3490.336836001152;3524.823758812049;3526.382882995517;3563.376409128392;3565.4295312749837;604.8306474187235;630.1776182082426;631.1574048645018;633.9904901426482;647.7862305439194;430.88366141141717;628.2806186915956;645.1838075816561;650.5933791380387;674.8346655069539;9020.82729245207;9328.415781955353;9392.248620110375;9450.291228157916;9522.14300712939;634.1692382978313;637.7799659117597;643.1927930447258;667.8263651450561;671.2716702377975;3547.467879817996;4359.195302110382;4430.269005614037;4577.977110114428;4668.439787225555;103253;103943.4802825981;111972.44013780043;113514;114889;52284;54158.18762718562;69588;75163;96380;46080.53919460763;62824.74350512964;68401.65799171072;69590;69787.30212697809;7996.440249182501;9973.3018688694;10000.199984001409;10061.849072263776;10094.646687365906;46369;46446;47346.76326618345;49223.507764921895;50441.451440340796;51830.740846297034;75234.24765752492;76495.61752191203;76646.6167669158;76869.61565192138;12546.804309245663;12551.748965020466;12846.100772945803;13117.737645247233;13384;14657.780133297796;14710.63223419423;14734;15261.771073434129;15495.922520387778;12082.939585302018;12094.939525302318;12155.352799876304;12195.207311524722;12721.491140354283;13502.594922152352;13504.189748615114;13736.381862815997;13816.24010679382;14138.22239776781;11339.71650708706;13133.34333283351;13149.671258218621;13727.862721372658;13758.174509529461;10524.000439916392;11093.5562577496;11216.831747523956;11293;11342.716432088933;10212.489375531046;10407.895921040692;10519.263651544625;10602.780680221565;10791.838122428013 04:40:51 INFO - PROCESS | 2191 | __end_tp_report 04:40:51 INFO - PROCESS | 2191 | __start_cc_report 04:40:51 INFO - PROCESS | 2191 | _x_x_mozilla_cycle_collect,354 04:40:51 INFO - PROCESS | 2191 | __end_cc_report 04:40:51 INFO - PROCESS | 2191 | __startTimestamp1481114451803__endTimestamp 04:40:51 INFO - PROCESS | 2191 | 04:40:51 INFO - PROCESS | 2191 | ------- Summary: start ------- 04:40:51 INFO - PROCESS | 2191 | Number of tests: 6 04:40:51 INFO - PROCESS | 2191 | 04:40:51 INFO - PROCESS | 2191 | [#0] dojo.html Cycles:165 Average:5698.47 Median:5941.44 stddev:667.01 (11.2%) stddev-sans-first:643.36 04:40:51 INFO - PROCESS | 2191 | Values: 3361.2 3375.2 3403.3 3411.1 3443.0 4989.8 5592.3 5624.4 5635.9 5636.4 5608.4 5726.2 5728.0 5759.2 5760.8 5151.0 5161.1 5166.6 5258.1 5389.3 5257.1 5263.7 5264.7 5266.2 5278.0 4360.9 4365.7 5116.6 5298.9 5349.4 5166.2 5271.3 5304.9 5327.3 5330.7 5062.6 5121.9 5133.8 5157.3 5241.1 4596.6 4780.2 5731.3 5739.9 5841.7 4803.0 6266.8 6267.2 6268.5 6301.4 6161.6 6171.7 6171.7 6198.9 6286.2 5876.8 5885.4 5902.6 5914.1 5954.6 6273.0 6342.1 6352.2 6359.2 6369.5 5962.9 6025.5 6102.7 6136.0 6143.0 6116.2 6172.9 6203.8 6219.9 6268.4 6156.3 6170.4 6173.9 6198.0 6205.1 5033.7 6066.1 6107.5 6141.6 6198.7 4934.4 4976.2 4978.1 4985.8 4990.3 4447.8 4448.0 4475.1 4486.9 4536.3 5419.0 5754.7 5775.0 5795.8 5940.1 6226.8 6227.3 6237.0 6262.0 6287.2 4940.7 5894.6 5898.7 5908.4 5948.0 5420.8 5427.9 5436.8 5437.3 5468.2 6146.6 6243.2 6292.9 6323.7 6364.3 6208.5 6251.2 6266.2 6275.9 6291.1 6345.7 6395.8 6407.7 6414.4 6428.5 5121.5 6076.6 6103.8 6109.6 6121.6 5239.2 6257.2 6259.2 6263.4 6271.1 6120.1 6153.2 6168.9 6178.5 6181.0 5991.6 6045.5 6098.5 6108.4 6188.6 5807.9 5869.6 5941.4 5966.5 5986.3 6102.0 6103.0 6107.1 6119.2 6123.8 4783.8 5921.7 5936.8 5984.7 6077.4 04:40:51 INFO - PROCESS | 2191 | 04:40:51 INFO - PROCESS | 2191 | [#1] ext.html Cycles:180 Average:66371.26 Median:36576.73 stddev:144206.48 (394.3%) stddev-sans-first:144526.07 04:40:51 INFO - PROCESS | 2191 | Values: 448.6 470.6 475.3 517.3 524.2 29401.7 30585.8 39165.8 40222.0 40224.0 38656.4 39077.6 39087.8 39139.4 39195.8 9217.9 9412.2 9420.5 9435.5 9438.5 8439.9 8601.4 9267.7 10960.5 11205.0 11212.9 11318.2 11322.0 11328.9 11342.2 9344.2 11210.0 11241.4 11244.0 11252.9 11028.7 11099.9 11109.0 11110.4 11125.3 37577.6 37677.2 37810.4 37811.0 37836.6 2624.4 3465.6 3470.2 3689.2 3894.7 28593.9 28619.4 29278.0 29308.6 29448.9 2707.3 3149.8 3165.7 3211.3 3312.5 467854.0 469247.0 470145.0 470228.0 475635.0 53726.7 54534.5 54602.5 54701.2 54732.5 56598.0 56727.7 56917.4 57056.7 57090.7 14671.8 14982.0 15147.5 15164.5 15165.5 11729.6 11917.5 11950.9 11973.0 11989.9 12833.3 13090.5 14243.4 14680.7 14684.6 5389.8 5568.3 5724.3 5837.2 6506.9 833.6 840.6 859.0 958.6 968.2 27245.0 27842.7 28962.6 29180.4 29331.4 907.7 1002.8 1024.7 1063.9 1131.5 11826.6 14638.5 14871.9 14908.1 15552.2 569243.0 578437.0 580641.0 584801.0 585979.0 51064.5 52424.0 52536.5 52691.7 52834.2 1291.9 1332.3 1335.6 1345.9 1351.9 26749.6 28584.8 28627.0 29149.9 29222.0 45931.0 46070.0 46414.0 46436.0 46567.8 562227.0 563201.0 563478.0 563665.0 564514.0 36616.8 37417.4 37650.9 37933.1 38041.0 42932.8 43071.6 43245.4 44125.0 44509.0 36286.0 36425.6 36536.6 37644.2 37879.0 31370.1 35465.3 36485.0 37068.1 37236.4 35221.3 35713.6 36307.6 36442.5 36500.6 27022.6 28511.6 31553.8 32475.2 33061.8 20560.3 20978.3 24014.0 24735.0 25110.5 04:40:51 INFO - PROCESS | 2191 | 04:40:51 INFO - PROCESS | 2191 | [#2] jquery.html Cycles:180 Average:31156.61 Median:387.82 stddev:82703.47 (21325.3%) stddev-sans-first:82903.10 04:40:51 INFO - PROCESS | 2191 | Values: 332.5 367.3 371.3 377.6 398.0 18976.9 19031.9 19140.0 19360.1 19472.6 19052.6 19520.5 19630.5 19853.8 19997.8 5504.3 5559.3 5806.7 5808.1 5830.0 5524.5 5699.7 5703.3 5704.6 5707.3 5431.5 5601.7 5662.3 5675.1 5686.7 4866.7 5561.7 5562.7 5616.2 5636.2 4926.7 4950.3 4955.2 4971.6 5165.7 12565.0 12703.7 12770.0 12775.4 12779.5 2119.4 2181.1 2260.7 2457.3 2622.6 9586.9 9630.0 9765.4 10131.5 10209.8 1818.8 1885.6 1889.9 1902.3 1907.9 113700.0 116933.0 117234.0 117713.0 118078.0 9023.5 11227.5 11446.7 11491.8 11659.7 14111.4 14188.6 14197.0 14199.7 14230.2 7994.5 8070.6 8146.8 8287.9 8306.1 6160.4 7918.0 8000.1 8145.1 8166.3 4364.5 4469.1 4473.1 4552.9 4558.6 1875.2 1924.5 1925.2 1927.9 1933.1 802.5 830.8 885.3 917.1 963.9 15182.6 19673.3 20759.4 20905.0 20931.0 898.4 904.7 911.5 922.4 943.3 8010.9 10403.9 10882.8 10922.8 10935.6 449553.0 450548.0 454495.0 536360.0 537496.0 93653.5 128936.4 131308.0 134338.6 140314.0 931.2 989.0 995.2 1000.3 1004.2 16044.0 17767.3 18297.5 18515.7 18968.1 43177.6 54533.0 55710.2 56270.0 56522.4 79261.8 79482.8 80162.0 80580.0 81950.6 6208.3 7746.6 7864.8 7930.3 8146.9 11378.2 12144.8 12438.7 12480.8 12585.3 8679.6 10464.6 10592.2 10804.8 10814.0 10548.1 10570.4 10752.1 10803.8 10958.9 8860.5 10129.1 10597.2 10791.8 11161.4 7715.3 7745.6 7894.9 7895.6 8127.6 7917.6 9408.3 10454.9 10501.8 10724.1 04:40:51 INFO - PROCESS | 2191 | 04:40:51 INFO - PROCESS | 2191 | [#3] mootools.html Cycles:180 Average:5363.70 Median:5205.85 stddev:2931.62 (56.3%) stddev-sans-first:2925.14 04:40:51 INFO - PROCESS | 2191 | Values: 1456.2 1465.9 1661.7 1763.2 1817.9 7443.6 7708.7 7946.8 8295.2 8354.0 7887.1 8150.4 8195.2 8246.0 8284.8 2254.7 2274.6 2281.5 2285.4 2285.5 2297.9 2312.2 2322.1 2330.4 2337.4 2269.1 2271.5 2300.9 2302.4 2309.8 1735.8 1958.0 1967.6 2231.5 2249.2 1943.3 2278.5 2305.3 2313.3 2315.7 8200.0 8231.5 8238.5 8306.2 8331.0 4965.5 5076.9 5129.7 5145.1 5149.0 2991.2 3195.4 3269.4 3503.8 3518.1 1013.1 1025.6 1069.8 1083.3 1083.7 10295.8 10398.7 10454.8 10527.3 10745.2 4471.5 4480.0 4614.6 4616.0 4651.9 9370.8 9444.6 9444.8 9452.9 9474.0 5125.4 5167.3 5173.3 5187.4 5202.6 3885.4 4119.9 4734.1 4741.0 4751.2 3711.8 3735.9 3845.1 3868.5 3870.8 1239.9 1273.5 1275.3 1283.2 1290.3 774.2 799.8 852.0 870.1 874.6 5076.7 5296.2 5368.8 5688.3 5818.8 852.4 871.4 876.5 900.5 901.9 3653.6 3662.6 3729.2 3760.9 3857.0 9465.0 9725.0 9898.5 9910.0 9963.5 9757.6 9828.8 9857.5 9874.7 9881.9 7233.9 7481.2 7572.1 7665.2 7683.3 5209.1 5617.4 5622.2 5682.5 5690.5 9114.6 9204.9 9273.3 9292.8 9351.0 9176.9 9280.8 9312.4 9334.3 9393.0 6548.0 6768.7 7059.6 7162.0 7172.8 7557.3 7750.0 7796.8 7924.2 7950.5 6979.7 7115.0 7143.9 7167.6 7249.6 6983.8 7055.4 7072.3 7093.5 7123.5 6346.4 6494.8 6583.1 6626.2 6636.2 4770.6 4823.1 4832.8 4873.6 4879.8 4727.9 4814.6 4815.2 4889.7 4976.9 04:40:51 INFO - PROCESS | 2191 | 04:40:51 INFO - PROCESS | 2191 | [#4] prototype.html Cycles:180 Average:4606.54 Median:5238.27 stddev:1471.65 (28.1%) stddev-sans-first:1439.16 04:40:51 INFO - PROCESS | 2191 | Values: 260.0 296.7 311.2 315.7 316.2 4290.7 4576.7 5332.9 5424.8 5489.7 3979.9 4846.4 5340.6 5396.8 5398.2 3413.5 3429.7 3953.8 4151.1 4165.7 3599.2 3715.5 3924.9 4055.2 4207.7 4068.4 4094.7 4120.9 4126.0 4144.6 3405.5 3511.2 4020.0 4113.8 4170.1 2869.6 3114.3 3583.3 3597.5 3601.2 3960.4 5044.6 5236.3 5244.1 5268.0 4133.4 4688.8 4697.3 4708.7 4710.7 4560.2 4999.2 5384.8 5707.3 5718.5 3679.6 3915.8 3940.2 3956.3 3970.0 4848.9 4935.5 5722.7 5924.9 5945.9 3598.5 3782.8 3885.6 4006.9 4011.0 3763.7 3934.0 4025.6 4064.4 4079.6 4143.1 4231.9 4555.8 4596.7 4656.7 4443.2 5412.5 5807.3 5822.3 5867.6 1136.9 1141.7 1240.6 1273.1 1300.7 863.1 879.5 889.9 891.4 892.0 4576.4 5035.7 5176.0 5243.9 5279.6 4421.9 5240.2 5281.9 5586.6 5781.8 5018.3 5537.4 5562.8 5565.2 5595.8 2476.1 2899.8 2976.9 2996.0 3041.8 5360.0 5501.9 5921.9 6170.4 6230.4 5109.8 6174.8 6175.6 6191.7 6233.3 4962.2 6188.9 6217.9 6257.3 6312.9 5315.7 5429.8 5772.5 6057.6 6067.8 5878.9 5961.8 5973.4 6000.6 6112.7 5515.6 5727.4 5824.3 6206.4 6332.5 3959.5 4019.7 4021.2 4022.8 4027.7 5343.4 5420.7 6151.7 6172.4 6201.7 4694.1 5649.4 5859.2 5875.9 5895.6 5900.4 5912.7 5928.7 5932.4 5934.7 4878.7 5515.7 5524.4 5550.5 5672.5 5855.7 5893.7 5907.7 5913.9 5934.2 5482.9 5558.4 5655.8 5784.3 5810.0 04:40:51 INFO - PROCESS | 2191 | 04:40:51 INFO - PROCESS | 2191 | [#5] yui.html Cycles:180 Average:20029.01 Median:3702.55 stddev:29603.40 (799.5%) stddev-sans-first:29650.81 04:40:51 INFO - PROCESS | 2191 | Values: 684.4 713.8 734.9 741.7 809.2 15007.6 15241.5 15841.2 15902.4 15919.5 14014.8 14247.6 14284.5 14304.7 14312.9 642.4 659.4 807.2 820.0 822.5 784.3 814.9 833.7 839.1 840.4 865.7 869.7 869.8 870.1 870.4 853.8 856.2 861.9 864.2 866.1 642.7 642.9 643.6 644.4 646.3 14393.3 14762.9 14765.8 14832.9 15130.8 14082.4 14538.6 14586.9 14681.4 14754.2 11574.5 11873.8 11912.7 11918.8 12183.8 3682.5 3686.9 3718.2 3750.2 3816.8 114361.4 118070.4 119104.0 120973.0 121068.0 10891.7 10896.5 11008.3 11056.3 11210.4 19537.3 20450.2 20531.2 21139.6 22670.8 7538.5 7544.7 7663.0 7733.8 7856.4 4318.0 4419.4 4426.1 4477.3 4510.1 3490.3 3524.8 3526.4 3563.4 3565.4 604.8 630.2 631.2 634.0 647.8 430.9 628.3 645.2 650.6 674.8 9020.8 9328.4 9392.2 9450.3 9522.1 634.2 637.8 643.2 667.8 671.3 3547.5 4359.2 4430.3 4578.0 4668.4 103253.0 103943.5 111972.4 113514.0 114889.0 52284.0 54158.2 69588.0 75163.0 96380.0 46080.5 62824.7 68401.7 69590.0 69787.3 7996.4 9973.3 10000.2 10061.8 10094.6 46369.0 46446.0 47346.8 49223.5 50441.5 51830.7 75234.2 76495.6 76646.6 76869.6 12546.8 12551.7 12846.1 13117.7 13384.0 14657.8 14710.6 14734.0 15261.8 15495.9 12082.9 12094.9 12155.4 12195.2 12721.5 13502.6 13504.2 13736.4 13816.2 14138.2 11339.7 13133.3 13149.7 13727.9 13758.2 10524.0 11093.6 11216.8 11293.0 11342.7 10212.5 10407.9 10519.3 10602.8 10791.8 04:40:51 INFO - PROCESS | 2191 | -------- Summary: end -------- 04:40:51 INFO - PROCESS | 2191 | 04:40:52 INFO - TEST-INFO | 2191: exit 0 04:40:52 INFO - TEST-OK | dromaeo_css | took 1117654ms 04:40:52 INFO - TEST-START | kraken 04:40:52 INFO - operating with platform_type : mac_ 04:40:52 INFO - Initialising browser for kraken test... 04:40:52 INFO - TEST-INFO | started process 2197 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/tmpp2jecd/profile http://localhost:49503/getInfo.html) 04:40:55 INFO - PROCESS | 2197 | 2016-12-07 04:40:55.689 plugin-container[2198:19368] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 04:40:55 INFO - PROCESS | 2197 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:40:55 INFO - PROCESS | 2197 | 2016-12-07 04:40:55.691 plugin-container[2198:19368] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b17, name = 'com.apple.CFPasteboardClient' 04:40:55 INFO - PROCESS | 2197 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:40:55 INFO - PROCESS | 2197 | 2016-12-07 04:40:55.691 plugin-container[2198:19368] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:40:55 INFO - PROCESS | 2197 | __metrics Screen width/height:1600/1200 04:40:55 INFO - PROCESS | 2197 | colorDepth:24 04:40:55 INFO - PROCESS | 2197 | Browser inner width/height: 1024/689 04:40:55 INFO - PROCESS | 2197 | __metrics 04:40:55 ERROR - PROCESS | 2197 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3220: TypeError: this.tabs is undefined 04:40:56 INFO - TEST-INFO | 2197: exit 0 04:40:56 INFO - Browser initialized. 04:40:56 INFO - Running cycle 1/1 for kraken test... 04:40:56 INFO - TEST-INFO | started process 2199 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/T/tmpp2jecd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:40:59 INFO - PROCESS | 2199 | 2016-12-07 04:40:59.485 plugin-container[2200:19487] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x873f, name = 'com.apple.tsm.portname' 04:40:59 INFO - PROCESS | 2199 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:40:59 INFO - PROCESS | 2199 | 2016-12-07 04:40:59.486 plugin-container[2200:19487] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b13, name = 'com.apple.CFPasteboardClient' 04:40:59 INFO - PROCESS | 2199 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:40:59 INFO - PROCESS | 2199 | 2016-12-07 04:40:59.486 plugin-container[2200:19487] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:41:09 INFO - PROCESS | 2199 | RSS: Main: 242114560 04:41:09 INFO - PROCESS | 2199 | 04:41:12 INFO - PROCESS | 2199 | Cycle 1(1): loaded http://localhost:49503/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49503/tests/kraken/driver.html?testName=audio-beat-detection) 04:41:13 INFO - PROCESS | 2199 | RSS: Main: 254222336 04:41:13 INFO - PROCESS | 2199 | 04:41:15 INFO - PROCESS | 2199 | Cycle 1(1): loaded http://localhost:49503/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49503/tests/kraken/driver.html?testName=audio-dft) 04:41:16 INFO - PROCESS | 2199 | RSS: Main: 261939200 04:41:16 INFO - PROCESS | 2199 | 04:41:19 INFO - PROCESS | 2199 | Cycle 1(1): loaded http://localhost:49503/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49503/tests/kraken/driver.html?testName=audio-fft) 04:41:20 INFO - PROCESS | 2199 | RSS: Main: 264667136 04:41:20 INFO - PROCESS | 2199 | 04:41:22 INFO - PROCESS | 2199 | Cycle 1(1): loaded http://localhost:49503/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49503/tests/kraken/driver.html?testName=audio-oscillator) 04:41:23 INFO - PROCESS | 2199 | RSS: Main: 266858496 04:41:23 INFO - PROCESS | 2199 | 04:41:25 INFO - PROCESS | 2199 | Cycle 1(1): loaded http://localhost:49503/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49503/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:41:25 INFO - PROCESS | 2199 | RSS: Main: 267153408 04:41:25 INFO - PROCESS | 2199 | 04:41:28 INFO - PROCESS | 2199 | Cycle 1(1): loaded http://localhost:49503/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49503/tests/kraken/driver.html?testName=imaging-darkroom) 04:41:29 INFO - PROCESS | 2199 | RSS: Main: 272576512 04:41:29 INFO - PROCESS | 2199 | 04:41:32 INFO - PROCESS | 2199 | Cycle 1(1): loaded http://localhost:49503/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49503/tests/kraken/driver.html?testName=imaging-desaturate) 04:41:32 INFO - PROCESS | 2199 | RSS: Main: 271499264 04:41:32 INFO - PROCESS | 2199 | 04:41:35 INFO - PROCESS | 2199 | Cycle 1(1): loaded http://localhost:49503/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49503/tests/kraken/driver.html?testName=json-parse-financial) 04:41:36 INFO - PROCESS | 2199 | RSS: Main: 271978496 04:41:36 INFO - PROCESS | 2199 | 04:41:37 INFO - PROCESS | 2199 | Cycle 1(1): loaded http://localhost:49503/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49503/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:41:38 INFO - PROCESS | 2199 | RSS: Main: 271364096 04:41:38 INFO - PROCESS | 2199 | 04:41:40 INFO - PROCESS | 2199 | Cycle 1(1): loaded http://localhost:49503/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49503/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:41:41 INFO - PROCESS | 2199 | RSS: Main: 271425536 04:41:41 INFO - PROCESS | 2199 | 04:41:43 INFO - PROCESS | 2199 | Cycle 1(1): loaded http://localhost:49503/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49503/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:41:44 INFO - PROCESS | 2199 | RSS: Main: 271450112 04:41:44 INFO - PROCESS | 2199 | 04:41:47 INFO - PROCESS | 2199 | Cycle 1(1): loaded http://localhost:49503/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49503/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:41:47 INFO - PROCESS | 2199 | RSS: Main: 271749120 04:41:47 INFO - PROCESS | 2199 | 04:41:50 INFO - PROCESS | 2199 | Cycle 1(1): loaded http://localhost:49503/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49503/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:41:51 INFO - PROCESS | 2199 | RSS: Main: 271810560 04:41:51 INFO - PROCESS | 2199 | 04:41:53 INFO - PROCESS | 2199 | Cycle 1(1): loaded http://localhost:49503/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49503/tests/kraken/driver.html?testName=ai-astar) 04:41:53 INFO - PROCESS | 2199 | RSS: Main: 272527360 04:41:53 INFO - PROCESS | 2199 | 04:41:53 INFO - PROCESS | 2199 | __start_tp_report 04:41:53 INFO - PROCESS | 2199 | _x_x_mozilla_page_load 04:41:53 INFO - PROCESS | 2199 | _x_x_mozilla_page_load_details 04:41:53 INFO - PROCESS | 2199 | |i|pagename|runs| 04:41:53 INFO - PROCESS | 2199 | |0;ai-astar;107;118;113;114;97;166;176;174;118;118 04:41:53 INFO - PROCESS | 2199 | |1;audio-beat-detection;150;121;122;152;154;146;115;116;137;127 04:41:53 INFO - PROCESS | 2199 | |2;audio-dft;219;200;197;196;197;201;210;231;194;194 04:41:53 INFO - PROCESS | 2199 | |3;audio-fft;84;59;59;83;59;65;87;84;99;71 04:41:53 INFO - PROCESS | 2199 | |4;audio-oscillator;86;72;86;70;70;70;83;70;97;114 04:41:53 INFO - PROCESS | 2199 | |5;imaging-gaussian-blur;89;87;89;87;90;86;89;87;90;86 04:41:53 INFO - PROCESS | 2199 | |6;imaging-darkroom;100;101;130;178;99;98;99;105;101;98 04:41:53 INFO - PROCESS | 2199 | |7;imaging-desaturate;92;102;92;92;100;89;93;95;94;91 04:41:53 INFO - PROCESS | 2199 | |8;json-parse-financial;56;57;56;56;57;57;61;68;87;88 04:41:53 INFO - PROCESS | 2199 | |9;json-stringify-tinderbox;71;76;80;77;72;72;70;73;88;105 04:41:53 INFO - PROCESS | 2199 | |10;stanford-crypto-aes;89;97;112;118;88;91;92;90;89;86 04:41:53 INFO - PROCESS | 2199 | |11;stanford-crypto-ccm;158;161;159;177;161;163;158;153;193;161 04:41:53 INFO - PROCESS | 2199 | |12;stanford-crypto-pbkdf2;169;176;172;175;178;172;177;172;185;242 04:41:53 INFO - PROCESS | 2199 | |13;stanford-crypto-sha256-iterative;71;67;68;74;84;66;75;89;89;96 04:41:53 INFO - PROCESS | 2199 | __end_tp_report 04:41:53 INFO - PROCESS | 2199 | __start_cc_report 04:41:53 INFO - PROCESS | 2199 | _x_x_mozilla_cycle_collect,917 04:41:53 INFO - PROCESS | 2199 | __end_cc_report 04:41:53 INFO - PROCESS | 2199 | __startTimestamp1481114513563__endTimestamp 04:41:53 INFO - PROCESS | 2199 | 04:41:53 INFO - PROCESS | 2199 | ------- Summary: start ------- 04:41:53 INFO - PROCESS | 2199 | Number of tests: 14 04:41:53 INFO - PROCESS | 2199 | 04:41:53 INFO - PROCESS | 2199 | [#0] ai-astar Cycles:10 Average:130.10 Median:142.00 stddev:29.71 (20.9%) stddev-sans-first:30.31 04:41:53 INFO - PROCESS | 2199 | Values: 107.0 118.0 113.0 114.0 97.0 166.0 176.0 174.0 118.0 118.0 04:41:53 INFO - PROCESS | 2199 | 04:41:53 INFO - PROCESS | 2199 | [#1] audio-beat-detection Cycles:10 Average:134.00 Median:141.50 stddev:15.56 (11.0%) stddev-sans-first:15.39 04:41:53 INFO - PROCESS | 2199 | Values: 150.0 121.0 122.0 152.0 154.0 146.0 115.0 116.0 137.0 127.0 04:41:53 INFO - PROCESS | 2199 | 04:41:53 INFO - PROCESS | 2199 | [#2] audio-dft Cycles:10 Average:203.90 Median:200.50 stddev:12.37 (6.2%) stddev-sans-first:11.85 04:41:53 INFO - PROCESS | 2199 | Values: 219.0 200.0 197.0 196.0 197.0 201.0 210.0 231.0 194.0 194.0 04:41:53 INFO - PROCESS | 2199 | 04:41:53 INFO - PROCESS | 2199 | [#3] audio-fft Cycles:10 Average:75.00 Median:83.50 stddev:14.26 (17.1%) stddev-sans-first:14.75 04:41:53 INFO - PROCESS | 2199 | Values: 84.0 59.0 59.0 83.0 59.0 65.0 87.0 84.0 99.0 71.0 04:41:53 INFO - PROCESS | 2199 | 04:41:53 INFO - PROCESS | 2199 | [#4] audio-oscillator Cycles:10 Average:81.80 Median:77.50 stddev:14.75 (19.0%) stddev-sans-first:15.56 04:41:53 INFO - PROCESS | 2199 | Values: 86.0 72.0 86.0 70.0 70.0 70.0 83.0 70.0 97.0 114.0 04:41:53 INFO - PROCESS | 2199 | 04:41:53 INFO - PROCESS | 2199 | [#5] imaging-gaussian-blur Cycles:10 Average:88.00 Median:89.00 stddev:1.56 (1.8%) stddev-sans-first:1.62 04:41:53 INFO - PROCESS | 2199 | Values: 89.0 87.0 89.0 87.0 90.0 86.0 89.0 87.0 90.0 86.0 04:41:53 INFO - PROCESS | 2199 | 04:41:53 INFO - PROCESS | 2199 | [#6] imaging-darkroom Cycles:10 Average:110.90 Median:138.00 stddev:25.46 (18.4%) stddev-sans-first:26.69 04:41:53 INFO - PROCESS | 2199 | Values: 100.0 101.0 130.0 178.0 99.0 98.0 99.0 105.0 101.0 98.0 04:41:53 INFO - PROCESS | 2199 | 04:41:53 INFO - PROCESS | 2199 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:92.00 stddev:4.06 (4.4%) stddev-sans-first:4.24 04:41:53 INFO - PROCESS | 2199 | Values: 92.0 102.0 92.0 92.0 100.0 89.0 93.0 95.0 94.0 91.0 04:41:53 INFO - PROCESS | 2199 | 04:41:53 INFO - PROCESS | 2199 | [#8] json-parse-financial Cycles:10 Average:64.30 Median:59.00 stddev:12.77 (21.6%) stddev-sans-first:13.19 04:41:53 INFO - PROCESS | 2199 | Values: 56.0 57.0 56.0 56.0 57.0 57.0 61.0 68.0 87.0 88.0 04:41:53 INFO - PROCESS | 2199 | 04:41:53 INFO - PROCESS | 2199 | [#9] json-stringify-tinderbox Cycles:10 Average:78.40 Median:74.50 stddev:10.78 (14.5%) stddev-sans-first:11.10 04:41:53 INFO - PROCESS | 2199 | Values: 71.0 76.0 80.0 77.0 72.0 72.0 70.0 73.0 88.0 105.0 04:41:53 INFO - PROCESS | 2199 | 04:41:53 INFO - PROCESS | 2199 | [#10] stanford-crypto-aes Cycles:10 Average:95.20 Median:89.50 stddev:10.92 (12.2%) stddev-sans-first:11.35 04:41:53 INFO - PROCESS | 2199 | Values: 89.0 97.0 112.0 118.0 88.0 91.0 92.0 90.0 89.0 86.0 04:41:53 INFO - PROCESS | 2199 | 04:41:53 INFO - PROCESS | 2199 | [#11] stanford-crypto-ccm Cycles:10 Average:164.40 Median:161.00 stddev:11.81 (7.3%) stddev-sans-first:12.29 04:41:53 INFO - PROCESS | 2199 | Values: 158.0 161.0 159.0 177.0 161.0 163.0 158.0 153.0 193.0 161.0 04:41:53 INFO - PROCESS | 2199 | 04:41:53 INFO - PROCESS | 2199 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.80 Median:176.50 stddev:21.61 (12.2%) stddev-sans-first:22.42 04:41:53 INFO - PROCESS | 2199 | Values: 169.0 176.0 172.0 175.0 178.0 172.0 177.0 172.0 185.0 242.0 04:41:53 INFO - PROCESS | 2199 | 04:41:53 INFO - PROCESS | 2199 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.90 Median:79.50 stddev:10.75 (13.5%) stddev-sans-first:11.11 04:41:53 INFO - PROCESS | 2199 | Values: 71.0 67.0 68.0 74.0 84.0 66.0 75.0 89.0 89.0 96.0 04:41:53 INFO - PROCESS | 2199 | -------- Summary: end -------- 04:41:53 INFO - PROCESS | 2199 | 04:41:54 INFO - TEST-INFO | 2199: exit 0 04:41:54 INFO - TEST-OK | kraken | took 62181ms 04:41:54 INFO - SUITE-END | took 1179s 04:41:54 INFO - Completed test suite (00:19:39) 04:41:54 INFO - javascript benchmark 04:41:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7093.4509828235405, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3361.2437201629623, 3375.1562109472634, 3403.3023230237804, 3411.1472131967007, 3443.0, 4989.77750451139, 5592.3009623797025, 5624.3531993820725, 5635.915461268084, 5636.408177141398, 5608.355039170497, 5726.226959360485, 5728.0, 5759.222504961829, 5760.798372056979, 5150.974245128769, 5161.122609156452, 5166.638335316529, 5258.079836028699, 5389.299391079154, 5257.080010998079, 5263.6578622389425, 5264.684118952875, 5266.157414813631, 5277.973610131944, 4360.934585981213, 4365.738055716652, 5116.565091967187, 5298.867528311785, 5349.384820745625, 5166.225066240057, 5271.28837606922, 5304.946950530522, 5327.280817089721, 5330.7068111253675, 5062.594992400599, 5121.923171152435, 5133.794648214067, 5157.277981082651, 5241.0828105081455, 4596.632269418438, 4780.235162374038, 5731.254936858223, 5739.885202295973, 5841.707914604295, 4803.0, 6266.78066267683, 6267.2165979252595, 6268.529860260499, 6301.369863013662, 6161.599496032743, 6171.691415429211, 6171.722272497748, 6198.946179149555, 6286.151369565142, 5876.794312199053, 5885.352611212763, 5902.6458412495385, 5914.142449344864, 5954.583179177459, 6273.027680709497, 6342.143810585604, 6352.174217351807, 6359.236891573041, 6369.490440764727, 5962.850928726816, 6025.457708806229, 6102.72537735803, 6136.018237082046, 6142.9864072427545, 6116.244470650255, 6172.8765424691255, 6203.8138855834395, 6219.937800621936, 6268.404501572343, 6156.322804491502, 6170.352113028068, 6173.9073913891325, 6198.0, 6205.131281620576, 5033.697978121251, 6066.120412540157, 6107.541934354941, 6141.6007959482495, 6198.690065496708, 4934.383202099738, 4976.178930476503, 4978.054169707744, 4985.825496107619, 4990.251462280687, 4447.844325448594, 4448.0, 4475.104979004147, 4486.887827804331, 4536.251518499411, 5419.0, 5754.712264386764, 5775.0, 5795.768169273266, 5940.138679891392, 6226.813195604139, 6227.346128656516, 6237.033259844731, 6262.029385445263, 6287.182666253358, 4940.7035577865445, 5894.616849904743, 5898.675572843535, 5908.438698323653, 5947.970260148758, 5420.783168673288, 5427.864303392446, 5436.809711660073, 5437.265969094122, 5468.234447177399, 6146.555559443527, 6243.188385509855, 6292.905606415816, 6323.652199129092, 6364.299927008118, 6208.534359923115, 6251.218597675291, 6266.248050234001, 6275.905861412174, 6291.119243306032, 6345.650989195638, 6395.776147834804, 6407.743690252524, 6414.390632889868, 6428.453581445442, 5121.539061484485, 6076.574639775174, 6103.761967187164, 6109.6475967989745, 6121.632702037892, 5239.187925871496, 6257.2491301044165, 6259.186305780219, 6263.3736626337, 6271.090691849748, 6120.051392034242, 6153.169322141453, 6168.907466388097, 6178.536609754196, 6181.0, 5991.610545314541, 6045.455908968214, 6098.5426093042315, 6108.389161083856, 6188.597741146991, 5807.883842323045, 5869.647821130746, 5941.435563621449, 5966.49284810796, 5986.311574169026, 6101.974255744646, 6102.9694851525455, 6107.053406721965, 6119.2350956130485, 6123.770712314271, 4783.784729687242, 5921.6743079131065, 5936.7922122725495, 5984.700764961822, 6077.4226448487325], "value": 5658.707573843129, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [448.63660435047603, 470.6046920586709, 475.28706939590614, 517.3403910014729, 524.2450870746126, 29401.705982940166, 30585.84707076464, 39165.80417097911, 40221.994450138685, 40223.994400140014, 38656.42015369765, 39077.609223907755, 39087.80456097716, 39139.41290880639, 39195.82412527622, 9217.907820921806, 9412.152906238438, 9420.481873496956, 9435.528223588793, 9438.480883551401, 8439.915600843975, 8601.354898382615, 9267.72196834096, 10960.506777195005, 11205.047570956438, 11212.943935280313, 11318.20772545922, 11321.981021708045, 11328.886711132865, 11342.206045576813, 9344.205742511895, 11210.0, 11241.381724005176, 11243.988041076342, 11252.887471125267, 11028.669139925814, 11099.944500277528, 11109.00018998286, 11110.388928608923, 11125.276857004268, 37577.62422375769, 37677.246455070745, 37810.43284350709, 37811.0, 37836.62163378359, 2624.448865738178, 3465.6187819339852, 3470.236547959445, 3689.1883785567134, 3894.7078969077434, 28593.85703071492, 28619.427611447863, 29277.97527086563, 29308.56037159444, 29448.852755736083, 2707.2690373599016, 3149.811011339327, 3165.7309128724087, 3211.2935154266024, 3312.4700047992205, 467854.0, 469247.0, 470145.0, 470228.0, 475635.0, 53726.731366342916, 54534.45465545373, 54602.45397546053, 54701.179482307794, 54732.452675472734, 56598.0, 56727.71636141793, 56917.43082569204, 57056.714716426155, 57090.714546427, 14671.77992330116, 14982.026168299026, 15147.54557363281, 15164.545063648107, 15165.483451654747, 11729.589464368706, 11917.463714132884, 11950.940245298718, 11973.0, 11989.940050299692, 12833.294168820617, 13090.476380944847, 14243.359048842827, 14680.706385872436, 14684.559463216121, 5389.83830485086, 5568.276124103841, 5724.282715185428, 5837.182794408786, 6506.902396464056, 833.5707110837923, 840.5671079394117, 858.9570521473902, 958.6021800952666, 968.162539403411, 27245.0, 27842.72157278442, 28962.565561516592, 29180.416391672046, 29331.413371732448, 907.6641642592283, 1002.7515742900137, 1024.6721049264313, 1063.9148868090533, 1131.4682099413262, 11826.5860694877, 14638.48765293231, 14871.851281487046, 14908.105513668997, 15552.222388880737, 569243.0, 578437.0, 580641.0, 584801.0, 585979.0, 51064.489355106714, 52423.95152096936, 52536.47463525392, 52691.73654131705, 52834.207486887724, 1291.922484650924, 1332.3404914567157, 1335.599320203935, 1345.8855997240148, 1351.86481351866, 26749.598756018288, 28584.83221208509, 28627.0, 29149.85425072861, 29222.0, 45931.0, 46070.0, 46414.0, 46436.0, 46567.83580410517, 562227.0, 563201.0, 563478.0, 563665.0, 564514.0, 36616.81691591525, 37417.43873841949, 37650.893649258775, 37933.103344832096, 38041.0, 42932.78533607312, 43071.56928430801, 43245.35131973086, 44125.0, 44509.0, 36286.0, 36425.635743642226, 36536.634633653324, 37644.2471150581, 37879.0, 31370.05889823309, 35465.29069418545, 36485.0, 37068.07329816668, 37236.44145337768, 35221.29557408889, 35713.64286357103, 36307.636923631486, 36442.54229830883, 36500.63499364972, 27022.594661079707, 28511.572326414705, 31553.842230788698, 32475.18812029718, 33061.84283550064, 20560.28039018627, 20978.2657606983, 24014.0, 24735.0, 25110.49779004446], "value": 19088.971505883943, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.5377724962302, 367.29479399552855, 371.2630428599231, 377.63369531554383, 398.00300247879056, 18976.905115474405, 19031.904840475778, 19140.0, 19360.128794204258, 19472.610547789052, 19052.618947621075, 19520.535959803, 19630.509237269074, 19853.801461985375, 19997.800021999774, 5504.284443022421, 5559.3328800543995, 5806.709664516758, 5808.070708686611, 5829.970850145764, 5524.475174858402, 5699.68651724155, 5703.287089113861, 5704.572157088214, 5707.258056452676, 5431.456854314557, 5601.747921343549, 5662.320521537421, 5675.063614503602, 5686.715664216773, 4866.732329721864, 5561.694106824123, 5562.749676264578, 5616.213730077792, 5636.15457681347, 4926.729029903354, 4950.2822090796635, 4955.207166853323, 4971.552560269557, 5165.66423182492, 12565.0, 12703.682407939783, 12770.0, 12775.425105870258, 12779.488820447172, 2119.3535971528677, 2181.073043956328, 2260.7174103237094, 2457.2751038443525, 2622.645942797717, 9586.856197157049, 9629.951850240774, 9765.414075155513, 10131.544080516394, 10209.795804083877, 1818.8272114149136, 1885.58517126232, 1889.9244030238774, 1902.3056584346614, 1907.8759880607715, 113700.0, 116933.0, 117234.0, 117713.0, 118078.0, 9023.458592484472, 11227.494762735696, 11446.713832154262, 11491.77016459666, 11659.708507287385, 14111.364988575539, 14188.64528386778, 14197.0, 14199.716005680035, 14230.2173380463, 7994.5203287802915, 8070.556119413372, 8146.75559733209, 8287.917120828835, 8306.127856575093, 6160.44555989963, 7917.960410197912, 8000.119986801447, 8145.144759800254, 8166.265036146775, 4364.476262848415, 4469.08383781324, 4473.105378924228, 4552.886177845514, 4558.635309175258, 1875.2124107874724, 1924.5381108533852, 1925.1529327096032, 1927.922883084661, 1933.1494142577221, 802.4623502253504, 830.8130670599066, 885.3183049052323, 917.1195652173988, 963.9084286992725, 15182.620434489227, 19673.311434099738, 20759.377218683465, 20905.0, 20931.0, 898.3711402018613, 904.7150147703452, 911.480456140007, 922.4004397141912, 943.32080901752, 8010.919890801018, 10403.9308404021, 10882.836757448644, 10922.836157457645, 10935.56257749681, 449553.0, 450548.0, 454495.0, 536359.9546006813, 537496.0, 93653.5317323409, 128936.3553182228, 131308.0, 134338.61137637327, 140314.0, 931.1759093202564, 989.0455710239653, 995.1541189988596, 1000.25980774228, 1004.2417974429259, 16044.037357758572, 17767.289308427517, 18297.45107646773, 18515.72226416578, 18968.051597420348, 43177.56822431736, 54533.0, 55710.16434753563, 56270.0, 56522.434775651716, 79261.8110728351, 79482.80775788483, 80162.0, 80580.0, 81950.59024705077, 6208.348123447154, 7746.559833652382, 7864.764057078297, 7930.325922296439, 8146.877796832934, 11378.203525753117, 12144.757104857677, 12438.689032774253, 12480.812787808372, 12585.307808070644, 8679.609417576097, 10464.63373781914, 10592.205584581034, 10804.837927431252, 10814.0, 10548.103411210133, 10570.41862697559, 10752.139828813833, 10803.758872338425, 10958.890411095786, 8860.468371897707, 10129.139023183112, 10597.15222782191, 10791.838122428013, 11161.386123763272, 7715.3441957432005, 7745.573993430416, 7894.881576776468, 7895.605219738875, 8127.634256458356, 7917.564533950457, 9408.341416100808, 10454.947725261325, 10501.78996420052, 10724.088452481314], "value": 8997.047490615783, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1456.1772598481857, 1465.904716193447, 1661.6759731852287, 1763.2329936477624, 1817.9272829086838, 7443.59060251686, 7708.653110610022, 7946.76159715208, 8295.17048295171, 8353.958230208847, 7887.053553573579, 8150.3887208459455, 8195.22145396188, 8245.958770206156, 8284.83430331393, 2254.6843441918104, 2274.613315736329, 2281.543691261746, 2285.371522831218, 2285.531466049464, 2297.8621282723007, 2312.1791763923816, 2322.0595658758148, 2330.4406942333803, 2337.4039619896903, 2269.103704036904, 2271.5343354612264, 2300.9309720708407, 2302.4128847143957, 2309.84985975911, 1735.7656716343258, 1957.9916343083323, 1967.6064787042649, 2231.520223152022, 2249.1902914950606, 1943.2615606069744, 2278.5215104828007, 2305.250793492122, 2313.306008197534, 2315.6642286868478, 8200.01599808027, 8231.506109633441, 8238.546879921601, 8306.169383061706, 8330.958345208235, 4965.478624744386, 5076.923846142311, 5129.7435128243815, 5145.125328694131, 5149.0474262261605, 2991.2073300575366, 3195.408849362875, 3269.4171604432468, 3503.8248087595516, 3518.1204698825295, 1013.1084645511976, 1025.6307729217551, 1069.7860427914447, 1083.3391631105019, 1083.7236504691332, 10295.79408411835, 10398.68803935883, 10454.79090418195, 10527.263091583593, 10745.194110441747, 4471.5081341052455, 4479.977600111979, 4614.561616646413, 4616.030633566921, 4651.930221046687, 9370.765730856783, 9444.574994125282, 9444.763880902896, 9452.8582071269, 9474.0, 5125.359330083739, 5167.328247327899, 5173.301604283373, 5187.377514698261, 5202.583793296527, 3885.3783394657285, 4119.938200926988, 4734.100520901018, 4741.0, 4751.216049351819, 3711.814409279579, 3735.860562528455, 3845.0964023454467, 3868.516435445569, 3870.845166193377, 1239.9318037507844, 1273.4969686973593, 1275.2858399296238, 1283.2300619628336, 1290.3096843188848, 774.2257742257742, 799.8240387114826, 851.9701810436605, 870.1298701298701, 874.5670892908051, 5076.7207803571155, 5296.205569164579, 5368.838934831883, 5688.288963879515, 5818.796342128006, 852.3735054734765, 871.3595507302127, 876.5047748022347, 900.4777229207044, 901.8647202919483, 3653.6116275815552, 3662.5788034376387, 3729.160938788805, 3760.9247815043545, 3856.9614303857165, 9464.95267523658, 9725.027497250217, 9898.505074746234, 9910.0, 9963.452010139512, 9757.560909759079, 9828.754281142885, 9857.457839818735, 9874.654387096562, 9881.901180988241, 7233.891491627524, 7481.21447248042, 7572.091349038151, 7665.233476652402, 7683.346915512244, 5209.114450543492, 5617.43825617435, 5622.2128901954575, 5682.516986056232, 5690.487856092972, 9114.589843457194, 9204.907950920406, 9273.258139348702, 9292.814143716952, 9350.953245234003, 9176.908230917605, 9280.767980800534, 9312.394694344846, 9334.27315946552, 9393.013733557878, 6547.9672601636685, 6768.695408706521, 7059.5764254144915, 7162.0, 7172.784816455514, 7557.319841214317, 7750.0, 7796.84406311882, 7924.167962363868, 7950.522968621901, 6979.720811167699, 7115.003899453977, 7143.892841607276, 7167.641617918979, 7249.601271929883, 6983.790486285419, 7055.435565154878, 7072.25741297177, 7093.467989900675, 7123.536970096927, 6346.365363463617, 6494.772682956074, 6583.144191255106, 6626.2379826318665, 6636.170478690164, 4770.570648641639, 4823.131836269506, 4832.806687732451, 4873.610111191168, 4879.756012199447, 4727.858164255078, 4814.614830813456, 4815.22956326986, 4889.682170658896, 4976.850694479172], "value": 4344.811938346512, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [259.95320842248395, 296.73886979458075, 311.2343634658739, 315.6653946816375, 316.2378667411536, 4290.678199135062, 4576.656750743695, 5332.893342133165, 5424.755885985135, 5489.709918169227, 3979.9403008954887, 4846.39420072491, 5340.599455040868, 5396.839679468913, 5398.245570189684, 3413.5221069050353, 3429.657034296563, 3953.782541960191, 4151.107511884937, 4165.666746660275, 3599.1541987632886, 3715.535558055243, 3924.8822535323843, 4055.2295063937904, 4207.747535147885, 4068.41008053832, 4094.7133700640966, 4120.876373708794, 4126.0, 4144.564820693829, 3405.5062016007787, 3511.17487390463, 4019.97990010051, 4113.753174809506, 4170.0817623893045, 2869.5552189410673, 3114.345987342661, 3583.33708263972, 3597.4963505109304, 3601.1717305019993, 3960.4059391091278, 5044.646874718771, 5236.329471969285, 5244.108501554745, 5267.973660131714, 4133.379993001044, 4688.765561721901, 4697.271922851964, 4708.717476951394, 4710.717356958559, 4560.247559152735, 4999.200127979542, 5384.838454846361, 5707.34365547959, 5718.48533631971, 3679.589868636021, 3915.8042097895277, 3940.211957608461, 3956.347202711549, 3969.98015009926, 4848.903021939576, 4935.544014515726, 5722.742476588522, 5924.940750592482, 5945.910811337833, 3598.5425902509523, 3782.7730336179366, 3885.611438856092, 4006.8998275042773, 4010.979945100256, 3763.6989040876665, 3934.0361611405388, 4025.611164148364, 4064.4106604542767, 4079.571644977294, 4143.129942712064, 4231.936520952188, 4555.790441635804, 4596.747178905192, 4656.697314674535, 4443.200223959719, 5412.512873841373, 5807.332156802022, 5822.302837698092, 5867.589268751147, 1136.9204155709187, 1141.7088642396136, 1240.5782034108265, 1273.1475702852329, 1300.674831292177, 863.1497974495118, 879.4591326334386, 889.8798662180652, 891.4072142025481, 892.0143241717808, 4576.405067341224, 5035.672681275705, 5175.972056347004, 5243.895122097613, 5279.551238144724, 4421.9336709949375, 5240.213967904845, 5281.943611277683, 5586.636868603528, 5781.82654520365, 5018.2974383586325, 5537.390887002426, 5562.802692936268, 5565.158312268352, 5595.776168953278, 2476.1209770531564, 2899.7970142089853, 2976.866041028159, 2995.955060674092, 3041.7718671099756, 5360.035193665178, 5501.889962200734, 5921.851953701106, 6170.444659980623, 6230.408111229426, 5109.795608175706, 6174.845628859314, 6175.5677102602385, 6191.721372538246, 6233.283172435137, 4962.206047032458, 6188.8762224755255, 6217.875642487215, 6257.2804127525915, 6312.936870631327, 5315.734213289397, 5429.782808687608, 5772.509336706427, 6057.636541807506, 6067.817965461043, 5878.911816322673, 5961.791337303173, 5973.432523910222, 6000.579669588293, 6112.663803490673, 5515.586331025109, 5727.422659803022, 5824.330202026821, 6206.410391012847, 6332.461740752087, 3959.544652365015, 4019.718619696593, 4021.235965166609, 4022.798860057044, 4027.697922655754, 5343.4389389113585, 5420.7289635518855, 6151.661658608819, 6172.351903050115, 6201.720922558406, 4694.108119457293, 5649.435056494318, 5859.1875899569295, 5875.941240587539, 5895.578316262803, 5900.43945825146, 5912.70436478183, 5928.687811753506, 5932.377100404568, 5934.732937017931, 4878.682885612424, 5515.669059856422, 5524.370310758256, 5550.531821883261, 5672.546196304368, 5855.677937713296, 5893.70531473416, 5907.734151963086, 5913.91129133072, 5934.219734079845, 5482.945170548243, 5558.360788509373, 5655.802046928337, 5784.2769653793275, 5810.01229790945], "value": 4132.4555712062875, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [684.3601232847285, 713.828681116532, 734.9412047036237, 741.7107328142025, 809.1706001348617, 15007.624809379771, 15241.466548670798, 15841.207939603031, 15902.44341448051, 15919.522414327574, 14014.789778153336, 14247.572572822806, 14284.500042498514, 14304.713905721905, 14312.928435357835, 642.4314481683721, 659.4032400677371, 807.1887752808449, 820.0282665041915, 822.5311572403732, 784.2862994674847, 814.8981377327834, 833.7332053742805, 839.0560619303284, 840.4159109418956, 865.671045002898, 869.7303835810887, 869.7955980344614, 870.0907551608552, 870.3776799588293, 853.7865533616596, 856.1695155698962, 861.8621020636731, 864.1833467373366, 866.06032454786, 642.7364780440043, 642.8521440068811, 643.6492111799081, 644.4135836388864, 646.2761706888315, 14393.280335983263, 14762.926185369004, 14765.77851332231, 14832.925835370863, 15130.773038404433, 14082.366293516714, 14538.636534086627, 14586.92706536471, 14681.412743490248, 14754.188519631416, 11574.537018519333, 11873.821892671616, 11912.702182445422, 11918.761624767543, 12183.817242741366, 3682.4844521766972, 3686.870959516404, 3718.2377612589353, 3750.1749615084636, 3816.790076545789, 114361.4281928585, 118070.40964795121, 119104.0, 120973.0, 121068.0, 10891.694722237498, 10896.509657065451, 11008.339499630049, 11056.336619802838, 11210.43947802623, 19537.316193933144, 20450.181992720423, 20531.178752850017, 21139.577208455743, 22670.773292266866, 7538.472306938571, 7544.735934242275, 7662.961685191538, 7733.806654833674, 7856.410769192334, 4317.988128522963, 4419.445958669917, 4426.114777044604, 4477.306017567283, 4510.075434535912, 3490.336836001152, 3524.823758812049, 3526.382882995517, 3563.376409128392, 3565.4295312749837, 604.8306474187235, 630.1776182082426, 631.1574048645018, 633.9904901426482, 647.7862305439194, 430.88366141141717, 628.2806186915956, 645.1838075816561, 650.5933791380387, 674.8346655069539, 9020.82729245207, 9328.415781955353, 9392.248620110375, 9450.291228157916, 9522.14300712939, 634.1692382978313, 637.7799659117597, 643.1927930447258, 667.8263651450561, 671.2716702377975, 3547.467879817996, 4359.195302110382, 4430.269005614037, 4577.977110114428, 4668.439787225555, 103253.0, 103943.4802825981, 111972.44013780043, 113514.0, 114889.0, 52284.0, 54158.18762718562, 69588.0, 75163.0, 96380.0, 46080.53919460763, 62824.74350512964, 68401.65799171072, 69590.0, 69787.30212697809, 7996.440249182501, 9973.3018688694, 10000.199984001409, 10061.849072263776, 10094.646687365906, 46369.0, 46446.0, 47346.76326618345, 49223.507764921895, 50441.451440340796, 51830.740846297034, 75234.24765752492, 76495.61752191203, 76646.6167669158, 76869.61565192138, 12546.804309245663, 12551.748965020466, 12846.100772945803, 13117.737645247233, 13384.0, 14657.780133297796, 14710.63223419423, 14734.0, 15261.771073434129, 15495.922520387778, 12082.939585302018, 12094.939525302318, 12155.352799876304, 12195.207311524722, 12721.491140354283, 13502.594922152352, 13504.189748615114, 13736.381862815997, 13816.24010679382, 14138.22239776781, 11339.71650708706, 13133.34333283351, 13149.671258218621, 13727.862721372658, 13758.174509529461, 10524.000439916392, 11093.5562577496, 11216.831747523956, 11293.0, 11342.716432088933, 10212.489375531046, 10407.895921040692, 10519.263651544625, 10602.780680221565, 10791.838122428013], "value": 7299.977300175887, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1579.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 118.0, 113.0, 114.0, 97.0, 166.0, 176.0, 174.0, 118.0, 118.0], "value": 130.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 121.0, 122.0, 152.0, 154.0, 146.0, 115.0, 116.0, 137.0, 127.0], "value": 134.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [219.0, 200.0, 197.0, 196.0, 197.0, 201.0, 210.0, 231.0, 194.0, 194.0], "value": 203.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 59.0, 59.0, 83.0, 59.0, 65.0, 87.0, 84.0, 99.0, 71.0], "value": 75.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 72.0, 86.0, 70.0, 70.0, 70.0, 83.0, 70.0, 97.0, 114.0], "value": 81.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 89.0, 87.0, 90.0, 86.0, 89.0, 87.0, 90.0, 86.0], "value": 88.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 101.0, 130.0, 178.0, 99.0, 98.0, 99.0, 105.0, 101.0, 98.0], "value": 110.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 102.0, 92.0, 92.0, 100.0, 89.0, 93.0, 95.0, 94.0, 91.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 56.0, 56.0, 57.0, 57.0, 61.0, 68.0, 87.0, 88.0], "value": 64.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 76.0, 80.0, 77.0, 72.0, 72.0, 70.0, 73.0, 88.0, 105.0], "value": 78.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 97.0, 112.0, 118.0, 88.0, 91.0, 92.0, 90.0, 89.0, 86.0], "value": 95.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 161.0, 159.0, 177.0, 161.0, 163.0, 158.0, 153.0, 193.0, 161.0], "value": 164.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 176.0, 172.0, 175.0, 178.0, 172.0, 177.0, 172.0, 185.0, 242.0], "value": 181.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 67.0, 68.0, 74.0, 84.0, 66.0, 75.0, 89.0, 89.0, 96.0], "value": 77.9, "unit": "score"}]}]} 04:41:54 INFO - Return code: 0 04:41:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:41:54 ERROR - # TBPL SUCCESS # 04:41:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:41:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:41:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:41:54 INFO - 2016-12-07 04:41:54.868 screenresolution[2204:19873] starting screenresolution argv=screenresolution get 04:41:54 INFO - 2016-12-07 04:41:54.871 screenresolution[2204:19873] Display 0: 1600x1200x32@60 04:41:54 INFO - 2016-12-07 04:41:54.877 screenresolution[2205:19876] starting screenresolution argv=screenresolution list 04:41:54 INFO - Available Modes on Display 0 04:41:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:41:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:41:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:41:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:41:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:41:55 INFO - Intel Iris: 04:41:55 INFO - Chipset Model: Intel Iris 04:41:55 INFO - Type: GPU 04:41:55 INFO - Bus: Built-In 04:41:55 INFO - VRAM (Dynamic, Max): 1536 MB 04:41:55 INFO - Vendor: Intel (0x8086) 04:41:55 INFO - Device ID: 0x0a2e 04:41:55 INFO - Revision ID: 0x0009 04:41:55 INFO - Displays: 04:41:55 INFO - Display: 04:41:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:41:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:41:55 INFO - Display Serial Number: 1600x1200 60 04:41:55 INFO - Main Display: Yes 04:41:55 INFO - Mirror: Off 04:41:55 INFO - Online: Yes 04:41:55 INFO - Rotation: Supported 04:41:55 INFO - Return code: 0 04:41:55 INFO - Running post-action listener: _resource_record_post_action 04:41:55 INFO - [mozharness: 2016-12-07 12:41:55.128985Z] Finished run-tests step (success) 04:41:55 INFO - Running post-run listener: _resource_record_post_run 04:41:55 INFO - Total resource usage - Wall time: 1213s; CPU: 54.0%; Read bytes: 1832448; Write bytes: 699195392; Read time: 14; Write time: 1999 04:41:55 INFO - TinderboxPrint: CPU usage
54.5% 04:41:55 INFO - TinderboxPrint: I/O read bytes / time
1,832,448 / 14 04:41:55 INFO - TinderboxPrint: I/O write bytes / time
699,195,392 / 1,999 04:41:55 INFO - TinderboxPrint: CPU idle
2,210.0 (45.5%) 04:41:55 INFO - TinderboxPrint: CPU system
982.0 (20.2%) 04:41:55 INFO - TinderboxPrint: CPU user
1,661.7 (34.2%) 04:41:55 INFO - TinderboxPrint: Swap in / out
385,798,144 / 0 04:41:55 INFO - install - Wall time: 33s; CPU: 55.0%; Read bytes: 384614912; Write bytes: 387155968; Read time: 28770; Write time: 804 04:41:55 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 1832448; Write bytes: 310781952; Read time: 14; Write time: 1185 04:41:55 INFO - Running post-run listener: _upload_blobber_files 04:41:55 INFO - Blob upload gear active. 04:41:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:41:55 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:41:55 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:41:55 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:41:56 INFO - (blobuploader) - INFO - Open directory for files ... 04:41:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:41:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:41:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:41:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:41:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:41:57 INFO - (blobuploader) - INFO - Done attempting. 04:41:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:41:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:41:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:41:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:41:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:41:58 INFO - (blobuploader) - INFO - Done attempting. 04:41:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:41:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:41:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:42:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:42:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:42:00 INFO - (blobuploader) - INFO - Done attempting. 04:42:00 INFO - (blobuploader) - INFO - Iteration through files over. 04:42:00 INFO - Return code: 0 04:42:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:42:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:42:00 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4ee8014d0e555c4daa7f1ace29cdd1ed1af4673d67bb08bf369a79f5c620d672fd0d1aa429cb0c3cb129ab3672efb6d516648490660cf78c20a466a266bcdb2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a6033bfef9e26bd7fc63647a0ffa293fb92aedec73bfd5c94cc7ee305a411a108908d7a05c440b307d0690e3d126d86762297ca1e24d0e5b8619c1d5f2a377c0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4b86ccbd467c995970e0201c917718704d30dffa540caaf1bbd864b97ab80be724cbaab506ef5398494419f05c4abd0912b3acf9f9986d65a6cef25fa22b1d56"} 04:42:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:42:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:42:00 INFO - Contents: 04:42:00 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4ee8014d0e555c4daa7f1ace29cdd1ed1af4673d67bb08bf369a79f5c620d672fd0d1aa429cb0c3cb129ab3672efb6d516648490660cf78c20a466a266bcdb2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a6033bfef9e26bd7fc63647a0ffa293fb92aedec73bfd5c94cc7ee305a411a108908d7a05c440b307d0690e3d126d86762297ca1e24d0e5b8619c1d5f2a377c0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4b86ccbd467c995970e0201c917718704d30dffa540caaf1bbd864b97ab80be724cbaab506ef5398494419f05c4abd0912b3acf9f9986d65a6cef25fa22b1d56"} 04:42:00 INFO - Running post-run listener: copy_logs_to_upload_dir 04:42:00 INFO - Copying logs to upload dir... 04:42:00 INFO - mkdir: /builds/slave/test/build/upload/logs 04:42:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.245125 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-12-07 04:42:00.605953) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-07 04:42:00.609530) ========= 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.qaajwuvpSI/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.ZTukW4cXNN/Listeners TMPDIR=/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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/4ee8014d0e555c4daa7f1ace29cdd1ed1af4673d67bb08bf369a79f5c620d672fd0d1aa429cb0c3cb129ab3672efb6d516648490660cf78c20a466a266bcdb2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a6033bfef9e26bd7fc63647a0ffa293fb92aedec73bfd5c94cc7ee305a411a108908d7a05c440b307d0690e3d126d86762297ca1e24d0e5b8619c1d5f2a377c0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4b86ccbd467c995970e0201c917718704d30dffa540caaf1bbd864b97ab80be724cbaab506ef5398494419f05c4abd0912b3acf9f9986d65a6cef25fa22b1d56"} build_url:https://queue.taskcluster.net/v1/task/fOK22v-9RLeWVpg8-HmZUw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010947 build_url: 'https://queue.taskcluster.net/v1/task/fOK22v-9RLeWVpg8-HmZUw/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/4ee8014d0e555c4daa7f1ace29cdd1ed1af4673d67bb08bf369a79f5c620d672fd0d1aa429cb0c3cb129ab3672efb6d516648490660cf78c20a466a266bcdb2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a6033bfef9e26bd7fc63647a0ffa293fb92aedec73bfd5c94cc7ee305a411a108908d7a05c440b307d0690e3d126d86762297ca1e24d0e5b8619c1d5f2a377c0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4b86ccbd467c995970e0201c917718704d30dffa540caaf1bbd864b97ab80be724cbaab506ef5398494419f05c4abd0912b3acf9f9986d65a6cef25fa22b1d56"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-07 04:42:00.643562) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 04:42:00.643885) ========= 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.qaajwuvpSI/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.ZTukW4cXNN/Listeners TMPDIR=/var/folders/hy/45ssh3ld6sx_27c31ssq2l9w00000w/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.005234 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 04:42:00.693211) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-07 04:42:00.693535) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-07 04:42:00.693864) ========= ========= Total master_lag: 0.26 =========