builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0007 starttime: 1491832741.7 results: success (0) buildid: 20170410045748 builduid: 62d43592062c4f1c916b99308730d2aa revision: 4f39d509a2e8d0173aa6bff8cf8ecd9d87fac7e4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-10 06:59:01.697299) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-10 06:59:01.697775) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-10 06:59:01.698053) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-10 06:59:01.725132) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 06:59:01.725513) ========= 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.7ItqocMtKR/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.T1wJJreoFW/Listeners TMPDIR=/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-04-10 06:59:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 19.6M=0.001s 2017-04-10 06:59:01 (19.6 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.207829 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 06:59:01.955656) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 06:59:01.956051) ========= 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.7ItqocMtKR/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.T1wJJreoFW/Listeners TMPDIR=/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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.029093 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 06:59:02.006655) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-10 06:59:02.007001) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 4f39d509a2e8d0173aa6bff8cf8ecd9d87fac7e4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 4f39d509a2e8d0173aa6bff8cf8ecd9d87fac7e4 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7ItqocMtKR/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.T1wJJreoFW/Listeners TMPDIR=/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-04-10 06:59:02,105 truncating revision to first 12 chars 2017-04-10 06:59:02,105 Setting DEBUG logging. 2017-04-10 06:59:02,106 attempt 1/10 2017-04-10 06:59:02,106 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/4f39d509a2e8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-10 06:59:02,852 unpacking tar archive at: mozilla-beta-4f39d509a2e8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.023565 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-10 06:59:03.053996) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-10 06:59:03.054313) ========= script_repo_revision: 4f39d509a2e8d0173aa6bff8cf8ecd9d87fac7e4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-10 06:59:03.054731) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-10 06:59:03.054997) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-10 06:59:03.074970) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-04-10 06:59:03.075358) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7ItqocMtKR/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.T1wJJreoFW/Listeners TMPDIR=/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 06:59:03 INFO - MultiFileLogger online at 20170410 06:59:03 in /builds/slave/test 06:59:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 06:59:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:59:03 INFO - {'append_to_log': False, 06:59:03 INFO - 'base_work_dir': '/builds/slave/test', 06:59:03 INFO - 'blob_upload_branch': 'Mozilla-Beta', 06:59:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:59:03 INFO - 'branch': 'Mozilla-Beta', 06:59:03 INFO - 'buildbot_json_path': 'buildprops.json', 06:59:03 INFO - 'config_files': ('talos/mac_config.py',), 06:59:03 INFO - 'default_actions': ('clobber', 06:59:03 INFO - 'read-buildbot-config', 06:59:03 INFO - 'download-and-extract', 06:59:03 INFO - 'populate-webroot', 06:59:03 INFO - 'create-virtualenv', 06:59:03 INFO - 'install', 06:59:03 INFO - 'run-tests'), 06:59:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:59:03 INFO - 'download_minidump_stackwalk': True, 06:59:03 INFO - 'download_symbols': 'ondemand', 06:59:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:59:03 INFO - 'tooltool.py': '/tools/tooltool.py', 06:59:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:59:03 INFO - '/tools/misc-python/virtualenv.py')}, 06:59:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:59:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:59:03 INFO - 'installer_path': 'installer.exe', 06:59:03 INFO - 'log_level': 'info', 06:59:03 INFO - 'log_name': 'talos', 06:59:03 INFO - 'log_to_console': True, 06:59:03 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:59:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:59:03 INFO - 'opt_config_files': (), 06:59:03 INFO - 'pip_index': False, 06:59:03 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:59:03 INFO - 'cmd': ('bash', 06:59:03 INFO - '-c', 06:59:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:59:03 INFO - 'enabled': True, 06:59:03 INFO - 'halt_on_failure': False, 06:59:03 INFO - 'name': 'check_screen_resolution'},), 06:59:03 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:59:03 INFO - 'cmd': ('bash', 06:59:03 INFO - '-c', 06:59:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:59:03 INFO - 'enabled': True, 06:59:03 INFO - 'halt_on_failure': False, 06:59:03 INFO - 'name': 'check_screen_resolution'},), 06:59:03 INFO - 'run_cmd_checks_enabled': True, 06:59:03 INFO - 'sps_profile': False, 06:59:03 INFO - 'sps_profile_interval': 0, 06:59:03 INFO - 'suite': 'dromaeojs-e10s', 06:59:03 INFO - 'system_bits': '32', 06:59:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:59:03 INFO - 'title': 't-yosemite-r7-0007', 06:59:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:59:03 INFO - 'use_talos_json': True, 06:59:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:59:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:59:03 INFO - 'work_dir': 'build'} 06:59:03 INFO - [mozharness: 2017-04-10 13:59:03.282139Z] Running clobber step. 06:59:03 INFO - Running pre-action listener: _resource_record_pre_action 06:59:03 INFO - Running main action method: clobber 06:59:03 INFO - rmtree: /builds/slave/test/build 06:59:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:59:05 INFO - Running post-action listener: _resource_record_post_action 06:59:05 INFO - [mozharness: 2017-04-10 13:59:05.883757Z] Finished clobber step (success) 06:59:05 INFO - [mozharness: 2017-04-10 13:59:05.883974Z] Running read-buildbot-config step. 06:59:05 INFO - Running pre-action listener: _resource_record_pre_action 06:59:05 INFO - Running main action method: read_buildbot_config 06:59:05 INFO - Using buildbot properties: 06:59:05 INFO - { 06:59:05 INFO - "project": "", 06:59:05 INFO - "product": "firefox", 06:59:05 INFO - "script_repo_revision": "production", 06:59:05 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 06:59:05 INFO - "repository": "", 06:59:05 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 06:59:05 INFO - "buildid": "20170410045748", 06:59:05 INFO - "pgo_build": "False", 06:59:05 INFO - "basedir": "/builds/slave/test", 06:59:05 INFO - "buildnumber": 32, 06:59:05 INFO - "slavename": "t-yosemite-r7-0007", 06:59:05 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 06:59:05 INFO - "platform": "yosemite_r7", 06:59:05 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 06:59:05 INFO - "branch": "mozilla-beta", 06:59:05 INFO - "repo_path": "releases/mozilla-beta", 06:59:05 INFO - "revision": "4f39d509a2e8d0173aa6bff8cf8ecd9d87fac7e4", 06:59:05 INFO - "stage_platform": "macosx64", 06:59:05 INFO - "builduid": "62d43592062c4f1c916b99308730d2aa", 06:59:05 INFO - "slavebuilddir": "test" 06:59:05 INFO - } 06:59:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/eHNgSB_US1eINl4ocrUeiQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg. 06:59:05 INFO - Running post-action listener: _resource_record_post_action 06:59:05 INFO - [mozharness: 2017-04-10 13:59:05.889687Z] Finished read-buildbot-config step (success) 06:59:05 INFO - [mozharness: 2017-04-10 13:59:05.889921Z] Running download-and-extract step. 06:59:05 INFO - Running pre-action listener: _resource_record_pre_action 06:59:05 INFO - Running main action method: download_and_extract 06:59:05 INFO - mkdir: /builds/slave/test/build/tests 06:59:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:59:05 INFO - trying https://queue.taskcluster.net/v1/task/eHNgSB_US1eINl4ocrUeiQ/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json 06:59:05 INFO - Downloading https://queue.taskcluster.net/v1/task/eHNgSB_US1eINl4ocrUeiQ/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 06:59:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eHNgSB_US1eINl4ocrUeiQ/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json'}, attempt #1 06:59:06 INFO - Downloaded 1165 bytes. 06:59:06 INFO - Reading from file /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 06:59:06 INFO - Using the following test package requirements: 06:59:06 INFO - {u'common': [u'firefox-53.0.en-US.mac.common.tests.zip'], 06:59:06 INFO - u'cppunittest': [u'firefox-53.0.en-US.mac.common.tests.zip', 06:59:06 INFO - u'firefox-53.0.en-US.mac.cppunittest.tests.zip'], 06:59:06 INFO - u'gtest': [u'firefox-53.0.en-US.mac.common.tests.zip', 06:59:06 INFO - u'firefox-53.0.en-US.mac.gtest.tests.zip'], 06:59:06 INFO - u'jittest': [u'firefox-53.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 06:59:06 INFO - u'mochitest': [u'firefox-53.0.en-US.mac.common.tests.zip', 06:59:06 INFO - u'firefox-53.0.en-US.mac.mochitest.tests.zip'], 06:59:06 INFO - u'mozbase': [u'firefox-53.0.en-US.mac.common.tests.zip'], 06:59:06 INFO - u'reftest': [u'firefox-53.0.en-US.mac.common.tests.zip', 06:59:06 INFO - u'firefox-53.0.en-US.mac.reftest.tests.zip'], 06:59:06 INFO - u'talos': [u'firefox-53.0.en-US.mac.common.tests.zip', 06:59:06 INFO - u'firefox-53.0.en-US.mac.talos.tests.zip'], 06:59:06 INFO - u'web-platform': [u'firefox-53.0.en-US.mac.common.tests.zip', 06:59:06 INFO - u'firefox-53.0.en-US.mac.web-platform.tests.zip'], 06:59:06 INFO - u'xpcshell': [u'firefox-53.0.en-US.mac.common.tests.zip', 06:59:06 INFO - u'firefox-53.0.en-US.mac.xpcshell.tests.zip']} 06:59:06 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip'] for test suite category: common 06:59:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eHNgSB_US1eINl4ocrUeiQ/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 06:59:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eHNgSB_US1eINl4ocrUeiQ/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 06:59:06 INFO - Fetch https://queue.taskcluster.net/v1/task/eHNgSB_US1eINl4ocrUeiQ/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 06:59:07 INFO - Expected file size: 16116454 06:59:07 INFO - Obtained file size: 16116454 06:59:14 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip', u'firefox-53.0.en-US.mac.talos.tests.zip'] for test suite category: talos 06:59:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eHNgSB_US1eINl4ocrUeiQ/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 06:59:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eHNgSB_US1eINl4ocrUeiQ/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 06:59:14 INFO - Fetch https://queue.taskcluster.net/v1/task/eHNgSB_US1eINl4ocrUeiQ/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 06:59:14 INFO - Expected file size: 16116454 06:59:14 INFO - Obtained file size: 16116454 06:59:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eHNgSB_US1eINl4ocrUeiQ/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip 06:59:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eHNgSB_US1eINl4ocrUeiQ/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip'}, attempt #1 06:59:21 INFO - Fetch https://queue.taskcluster.net/v1/task/eHNgSB_US1eINl4ocrUeiQ/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip into memory 06:59:22 INFO - Expected file size: 14403650 06:59:22 INFO - Obtained file size: 14403650 06:59:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:59:22 INFO - trying https://queue.taskcluster.net/v1/task/eHNgSB_US1eINl4ocrUeiQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg 06:59:22 INFO - Downloading https://queue.taskcluster.net/v1/task/eHNgSB_US1eINl4ocrUeiQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0.en-US.mac.dmg 06:59:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eHNgSB_US1eINl4ocrUeiQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg'}, attempt #1 06:59:24 INFO - Downloaded 58735592 bytes. 06:59:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eHNgSB_US1eINl4ocrUeiQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg 06:59:24 INFO - mkdir: /builds/slave/test/properties 06:59:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:59:24 INFO - Writing to file /builds/slave/test/properties/build_url 06:59:24 INFO - Contents: 06:59:24 INFO - build_url:https://queue.taskcluster.net/v1/task/eHNgSB_US1eINl4ocrUeiQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg 06:59:24 INFO - Running post-action listener: _resource_record_post_action 06:59:24 INFO - Running post-action listener: set_extra_try_arguments 06:59:24 INFO - [mozharness: 2017-04-10 13:59:24.919240Z] Finished download-and-extract step (success) 06:59:24 INFO - [mozharness: 2017-04-10 13:59:24.919377Z] Running populate-webroot step. 06:59:24 INFO - Running pre-action listener: _resource_record_pre_action 06:59:24 INFO - Running main action method: populate_webroot 06:59:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:59:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:59:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:59:24 INFO - '--tppagecycles', 06:59:24 INFO - '7'], 06:59:24 INFO - 'tests': ['tsvgm']}}, 06:59:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:59:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:59:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:59:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:59:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:59:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:59:24 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 06:59:24 INFO - 'talos_options': ['--disable-e10s'], 06:59:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:59:24 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:59:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:59:24 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 06:59:24 INFO - 'talos_options': ['--disable-e10s'], 06:59:24 INFO - 'tests': ['damp', 'tps']}, 06:59:24 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:59:24 INFO - 'tests': ['damp', 'tps']}, 06:59:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:59:24 INFO - 'tests': ['dromaeo_dom']}, 06:59:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:59:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:59:24 INFO - 'tests': ['basic_compositor_video']}, 06:59:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:59:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:59:24 INFO - 'tests': ['a11yr', 06:59:24 INFO - 'ts_paint', 06:59:24 INFO - 'tpaint', 06:59:24 INFO - 'sessionrestore', 06:59:24 INFO - 'sessionrestore_no_auto_restore', 06:59:24 INFO - 'tabpaint']}, 06:59:24 INFO - 'other-e10s': {'tests': ['a11yr', 06:59:24 INFO - 'ts_paint', 06:59:24 INFO - 'tpaint', 06:59:24 INFO - 'sessionrestore', 06:59:24 INFO - 'sessionrestore_no_auto_restore', 06:59:24 INFO - 'tabpaint']}, 06:59:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:59:24 INFO - 'ts_paint', 06:59:24 INFO - 'tpaint', 06:59:24 INFO - 'sessionrestore', 06:59:24 INFO - 'sessionrestore_no_auto_restore', 06:59:24 INFO - 'tabpaint']}, 06:59:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:59:24 INFO - 'ts_paint', 06:59:24 INFO - 'tpaint', 06:59:24 INFO - 'sessionrestore', 06:59:24 INFO - 'sessionrestore_no_auto_restore', 06:59:24 INFO - 'tabpaint']}, 06:59:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:59:24 INFO - 'tests': ['a11yr', 06:59:24 INFO - 'ts_paint', 06:59:24 INFO - 'tpaint', 06:59:24 INFO - 'sessionrestore', 06:59:24 INFO - 'sessionrestore_no_auto_restore', 06:59:24 INFO - 'tabpaint']}, 06:59:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:59:24 INFO - 'tests': ['a11yr', 06:59:24 INFO - 'ts_paint', 06:59:24 INFO - 'tpaint', 06:59:24 INFO - 'sessionrestore', 06:59:24 INFO - 'sessionrestore_no_auto_restore', 06:59:24 INFO - 'tabpaint']}, 06:59:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:59:24 INFO - 'tests': ['tsvgx', 06:59:24 INFO - 'tsvgr_opacity', 06:59:24 INFO - 'tart', 06:59:24 INFO - 'tscrollx', 06:59:24 INFO - 'cart', 06:59:24 INFO - 'tsvg_static']}, 06:59:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:59:24 INFO - 'tsvgr_opacity', 06:59:24 INFO - 'tart', 06:59:24 INFO - 'tscrollx', 06:59:24 INFO - 'cart', 06:59:24 INFO - 'tsvg_static']}, 06:59:24 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 06:59:24 INFO - 'talos_options': ['--disable-e10s'], 06:59:24 INFO - 'tests': ['tp5o']}, 06:59:24 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:59:24 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 06:59:24 INFO - 'talos_options': ['--disable-e10s', 06:59:24 INFO - '--xperf_path', 06:59:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:59:24 INFO - 'tests': ['tp5n']}, 06:59:24 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:59:24 INFO - 'talos_options': ['--xperf_path', 06:59:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:59:24 INFO - 'tests': ['tp5n']}}, 06:59:24 INFO - 'talos.zip': {'path': '', 06:59:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:59:24 INFO - Running post-action listener: _resource_record_post_action 06:59:24 INFO - [mozharness: 2017-04-10 13:59:24.937878Z] Finished populate-webroot step (success) 06:59:24 INFO - [mozharness: 2017-04-10 13:59:24.938019Z] Running create-virtualenv step. 06:59:24 INFO - Running pre-action listener: _resource_record_pre_action 06:59:24 INFO - Running main action method: create_virtualenv 06:59:24 INFO - Creating virtualenv /builds/slave/test/build/venv 06:59:24 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 06:59:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:59:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:59:25 INFO - Using real prefix '/tools/python27' 06:59:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:59:25 INFO - Installing distribute.............................................................................................................................................................................................done. 06:59:28 INFO - Installing pip.................done. 06:59:28 INFO - Return code: 0 06:59:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:59:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:59:28 INFO - Reading from file tmpfile_stdout 06:59:28 INFO - Output received: 06:59:28 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) 06:59:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:59:28 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')]} 06:59:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:59:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:28 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')]} 06:59:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:59:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:28 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 0x10ea71b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea74768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe709dd40e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e84fd30>, '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 0x10e776db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e844be8>, '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.7ItqocMtKR/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.T1wJJreoFW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 06:59:28 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 06:59:28 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 06:59:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7ItqocMtKR/Render', 06:59:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:59:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:59:28 INFO - 'HOME': '/Users/cltbld', 06:59:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:59:28 INFO - 'LOGNAME': 'cltbld', 06:59:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:28 INFO - 'MOZ_NO_REMOTE': '1', 06:59:28 INFO - 'NO_EM_RESTART': '1', 06:59:28 INFO - 'PAGER': '/bin/cat', 06:59:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:59:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:59:28 INFO - 'PWD': '/builds/slave/test', 06:59:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:59:28 INFO - 'SHELL': '/bin/bash', 06:59:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.T1wJJreoFW/Listeners', 06:59:28 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 06:59:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:59:28 INFO - 'USER': 'cltbld', 06:59:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:59:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:59:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:28 INFO - 'XPC_FLAGS': '0x0', 06:59:28 INFO - 'XPC_SERVICE_NAME': '0', 06:59:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:59:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:59:29 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 06:59:29 INFO - Cleaning up... 06:59:29 INFO - Return code: 0 06:59:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:59:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:59:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:59:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:59:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:59:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ea71b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea74768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe709dd40e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e84fd30>, '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 0x10e776db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e844be8>, '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.7ItqocMtKR/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.T1wJJreoFW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 06:59:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:59:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:59:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7ItqocMtKR/Render', 06:59:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:59:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:59:29 INFO - 'HOME': '/Users/cltbld', 06:59:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:59:29 INFO - 'LOGNAME': 'cltbld', 06:59:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:29 INFO - 'MOZ_NO_REMOTE': '1', 06:59:29 INFO - 'NO_EM_RESTART': '1', 06:59:29 INFO - 'PAGER': '/bin/cat', 06:59:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:59:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:59:29 INFO - 'PWD': '/builds/slave/test', 06:59:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:59:29 INFO - 'SHELL': '/bin/bash', 06:59:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.T1wJJreoFW/Listeners', 06:59:29 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 06:59:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:59:29 INFO - 'USER': 'cltbld', 06:59:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:59:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:59:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:29 INFO - 'XPC_FLAGS': '0x0', 06:59:29 INFO - 'XPC_SERVICE_NAME': '0', 06:59:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:59:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:59:29 INFO - Downloading/unpacking psutil>=3.1.1 06:59: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 06:59: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 06:59: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 06:59: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 06:59: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 06:59: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 06:59:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:59:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:59:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:59:33 INFO - Installing collected packages: psutil 06:59:33 INFO - Running setup.py install for psutil 06:59:33 INFO - building 'psutil._psutil_osx' extension 06:59:33 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 06:59:33 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 06:59:33 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 06:59:33 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 06:59:33 INFO - building 'psutil._psutil_posix' extension 06:59:33 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 06:59:34 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:59:34 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:59:34 INFO - ^ 06:59:34 INFO - 1 warning generated. 06:59:34 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 06:59:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:59:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:59:34 INFO - Successfully installed psutil 06:59:34 INFO - Cleaning up... 06:59:34 INFO - Return code: 0 06:59:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:59:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:59:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:59:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:59:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:59:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ea71b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea74768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe709dd40e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e84fd30>, '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 0x10e776db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e844be8>, '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.7ItqocMtKR/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.T1wJJreoFW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 06:59:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:59:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:59:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7ItqocMtKR/Render', 06:59:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:59:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:59:34 INFO - 'HOME': '/Users/cltbld', 06:59:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:59:34 INFO - 'LOGNAME': 'cltbld', 06:59:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:34 INFO - 'MOZ_NO_REMOTE': '1', 06:59:34 INFO - 'NO_EM_RESTART': '1', 06:59:34 INFO - 'PAGER': '/bin/cat', 06:59:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:59:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:59:34 INFO - 'PWD': '/builds/slave/test', 06:59:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:59:34 INFO - 'SHELL': '/bin/bash', 06:59:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.T1wJJreoFW/Listeners', 06:59:34 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 06:59:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:59:34 INFO - 'USER': 'cltbld', 06:59:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:59:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:59:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:34 INFO - 'XPC_FLAGS': '0x0', 06:59:34 INFO - 'XPC_SERVICE_NAME': '0', 06:59:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:59:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:59:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:59:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:59:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:59:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:59:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:59:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:59:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:59:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:59:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:59:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:59:37 INFO - Installing collected packages: mozsystemmonitor 06:59:37 INFO - Running setup.py install for mozsystemmonitor 06:59:37 INFO - Successfully installed mozsystemmonitor 06:59:37 INFO - Cleaning up... 06:59:37 INFO - Return code: 0 06:59:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:59:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:59:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:59:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:59:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:59:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ea71b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea74768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe709dd40e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e84fd30>, '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 0x10e776db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e844be8>, '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.7ItqocMtKR/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.T1wJJreoFW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 06:59:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:59:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:59:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7ItqocMtKR/Render', 06:59:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:59:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:59:37 INFO - 'HOME': '/Users/cltbld', 06:59:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:59:37 INFO - 'LOGNAME': 'cltbld', 06:59:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:37 INFO - 'MOZ_NO_REMOTE': '1', 06:59:37 INFO - 'NO_EM_RESTART': '1', 06:59:37 INFO - 'PAGER': '/bin/cat', 06:59:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:59:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:59:37 INFO - 'PWD': '/builds/slave/test', 06:59:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:59:37 INFO - 'SHELL': '/bin/bash', 06:59:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.T1wJJreoFW/Listeners', 06:59:37 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 06:59:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:59:37 INFO - 'USER': 'cltbld', 06:59:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:59:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:59:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:37 INFO - 'XPC_FLAGS': '0x0', 06:59:37 INFO - 'XPC_SERVICE_NAME': '0', 06:59:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:59:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:59:37 INFO - Downloading/unpacking jsonschema==2.5.1 06:59: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 06:59: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 06:59: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 06:59: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 06:59: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 06:59: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 06:59:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:59:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:59:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:59:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:59:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:59:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:59:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:59:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:59:40 INFO - Downloading functools32-3.2.3-2.tar.gz 06:59:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:59:40 INFO - warning: no files found matching '*.txt' 06:59:40 INFO - no previously-included directories found matching 'build' 06:59:40 INFO - no previously-included directories found matching 'dist' 06:59:40 INFO - no previously-included directories found matching '.git*' 06:59:40 INFO - Installing collected packages: jsonschema, functools32 06:59:40 INFO - Running setup.py install for functools32 06:59:40 INFO - warning: no files found matching '*.txt' 06:59:40 INFO - no previously-included directories found matching 'build' 06:59:40 INFO - no previously-included directories found matching 'dist' 06:59:40 INFO - no previously-included directories found matching '.git*' 06:59:40 INFO - Successfully installed jsonschema functools32 06:59:40 INFO - Cleaning up... 06:59:41 INFO - Return code: 0 06:59:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:59:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:59:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:59:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:59:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:59:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ea71b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea74768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe709dd40e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e84fd30>, '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 0x10e776db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e844be8>, '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.7ItqocMtKR/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.T1wJJreoFW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 06:59:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:59:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:59:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7ItqocMtKR/Render', 06:59:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:59:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:59:41 INFO - 'HOME': '/Users/cltbld', 06:59:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:59:41 INFO - 'LOGNAME': 'cltbld', 06:59:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:41 INFO - 'MOZ_NO_REMOTE': '1', 06:59:41 INFO - 'NO_EM_RESTART': '1', 06:59:41 INFO - 'PAGER': '/bin/cat', 06:59:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:59:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:59:41 INFO - 'PWD': '/builds/slave/test', 06:59:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:59:41 INFO - 'SHELL': '/bin/bash', 06:59:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.T1wJJreoFW/Listeners', 06:59:41 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 06:59:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:59:41 INFO - 'USER': 'cltbld', 06:59:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:59:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:59:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:41 INFO - 'XPC_FLAGS': '0x0', 06:59:41 INFO - 'XPC_SERVICE_NAME': '0', 06:59:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:59:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:59:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:59:41 INFO - Cleaning up... 06:59:41 INFO - Return code: 0 06:59:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:59:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:59:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:59:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:59:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:59:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ea71b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea74768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe709dd40e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e84fd30>, '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 0x10e776db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e844be8>, '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.7ItqocMtKR/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.T1wJJreoFW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 06:59:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:59:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:59:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7ItqocMtKR/Render', 06:59:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:59:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:59:41 INFO - 'HOME': '/Users/cltbld', 06:59:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:59:41 INFO - 'LOGNAME': 'cltbld', 06:59:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:41 INFO - 'MOZ_NO_REMOTE': '1', 06:59:41 INFO - 'NO_EM_RESTART': '1', 06:59:41 INFO - 'PAGER': '/bin/cat', 06:59:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:59:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:59:41 INFO - 'PWD': '/builds/slave/test', 06:59:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:59:41 INFO - 'SHELL': '/bin/bash', 06:59:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.T1wJJreoFW/Listeners', 06:59:41 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 06:59:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:59:41 INFO - 'USER': 'cltbld', 06:59:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:59:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:59:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:41 INFO - 'XPC_FLAGS': '0x0', 06:59:41 INFO - 'XPC_SERVICE_NAME': '0', 06:59:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:59:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:59:41 INFO - Downloading/unpacking blobuploader==1.2.4 06:59:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:59:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:59:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:59:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:59:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:59:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:59:44 INFO - Downloading blobuploader-1.2.4.tar.gz 06:59:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:59:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:59:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:59:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:59:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:59:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:59:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:59:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:59:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:59:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:59:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:59:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:59:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:59:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:59:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:59:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:59:45 INFO - Downloading docopt-0.6.1.tar.gz 06:59:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:59:45 INFO - Installing collected packages: blobuploader, requests, docopt 06:59:45 INFO - Running setup.py install for blobuploader 06:59:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:59:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:59:45 INFO - Running setup.py install for requests 06:59:46 INFO - Running setup.py install for docopt 06:59:46 INFO - Successfully installed blobuploader requests docopt 06:59:46 INFO - Cleaning up... 06:59:46 INFO - Return code: 0 06:59:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:59: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')]} 06:59:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:59:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59: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')]} 06:59:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:59:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ea71b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea74768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe709dd40e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e84fd30>, '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 0x10e776db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e844be8>, '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.7ItqocMtKR/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.T1wJJreoFW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 06:59:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:59:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:59:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7ItqocMtKR/Render', 06:59:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:59:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:59:46 INFO - 'HOME': '/Users/cltbld', 06:59:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:59:46 INFO - 'LOGNAME': 'cltbld', 06:59:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:46 INFO - 'MOZ_NO_REMOTE': '1', 06:59:46 INFO - 'NO_EM_RESTART': '1', 06:59:46 INFO - 'PAGER': '/bin/cat', 06:59:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:59:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:59:46 INFO - 'PWD': '/builds/slave/test', 06:59:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:59:46 INFO - 'SHELL': '/bin/bash', 06:59:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.T1wJJreoFW/Listeners', 06:59:46 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 06:59:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:59:46 INFO - 'USER': 'cltbld', 06:59:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:59:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:59:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:46 INFO - 'XPC_FLAGS': '0x0', 06:59:46 INFO - 'XPC_SERVICE_NAME': '0', 06:59:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:59:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:59:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:59:46 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-GtMCsJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:59:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:59:46 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-5Ksy72-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:59:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:59:46 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-8jFPck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:59:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:59:47 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-Fzu0sQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:59:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:59:47 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-hD4wyq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:59:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:59:47 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-NZLp27-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:59:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:59:47 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-JxSIOz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:59:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:59:47 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-55Tn8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:59:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:59:47 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-y85GU0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:59:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:59:47 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-ORYcBW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:59:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:59:47 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-CvjHnl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:59:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:59:47 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-iEkw1t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:59:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:59:47 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-JcAYXG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:59:48 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-0I941F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:59:48 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-TgUrF5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:59:48 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-iqi_XJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:59:48 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-qnn5Kp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:59:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:59:48 INFO - Running setup.py install for manifestparser 06:59:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:59:48 INFO - Running setup.py install for mozcrash 06:59:48 INFO - Running setup.py install for mozdebug 06:59:48 INFO - Running setup.py install for mozdevice 06:59:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:59:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:59:49 INFO - Running setup.py install for mozfile 06:59:49 INFO - Running setup.py install for mozhttpd 06:59:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:59:49 INFO - Running setup.py install for mozinfo 06:59:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:59:49 INFO - Running setup.py install for mozInstall 06:59:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:59:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:59:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:59:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:59:49 INFO - Running setup.py install for mozleak 06:59:49 INFO - Running setup.py install for mozlog 06:59:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:59:49 INFO - Running setup.py install for moznetwork 06:59:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:59:50 INFO - Running setup.py install for mozprocess 06:59:50 INFO - Running setup.py install for mozprofile 06:59:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:59:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:59:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:59:50 INFO - Running setup.py install for mozrunner 06:59:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:59:50 INFO - Running setup.py install for mozscreenshot 06:59:50 INFO - Running setup.py install for moztest 06:59:50 INFO - Running setup.py install for mozversion 06:59:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:59:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:59:51 INFO - Cleaning up... 06:59:51 INFO - Return code: 0 06:59:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:59:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:59:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:59:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:59:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ea71b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea74768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe709dd40e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e84fd30>, '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 0x10e776db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e844be8>, '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.7ItqocMtKR/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.T1wJJreoFW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 06:59:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:59:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:59:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7ItqocMtKR/Render', 06:59:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:59:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:59:51 INFO - 'HOME': '/Users/cltbld', 06:59:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:59:51 INFO - 'LOGNAME': 'cltbld', 06:59:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:51 INFO - 'MOZ_NO_REMOTE': '1', 06:59:51 INFO - 'NO_EM_RESTART': '1', 06:59:51 INFO - 'PAGER': '/bin/cat', 06:59:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:59:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:59:51 INFO - 'PWD': '/builds/slave/test', 06:59:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:59:51 INFO - 'SHELL': '/bin/bash', 06:59:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.T1wJJreoFW/Listeners', 06:59:51 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 06:59:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:59:51 INFO - 'USER': 'cltbld', 06:59:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:59:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:59:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:51 INFO - 'XPC_FLAGS': '0x0', 06:59:51 INFO - 'XPC_SERVICE_NAME': '0', 06:59:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:59:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:59:51 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-lJjpsE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:59:51 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 06:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:59:51 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-lYGyXC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:59:51 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)) 06:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:59:51 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-tNaMy1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:59:51 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)) 06:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:59:51 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-VlGjzA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:59:51 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)) 06:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:59:51 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-rBjlZd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:59:51 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)) 06:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:59:51 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-zhCt3k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:59:51 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)) 06:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:59:51 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-JGflzu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:59:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 06:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:59:52 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-ZVsmRO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:59:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 06:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:59:52 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-kipSZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:59:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 06:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:59:52 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-_nHVXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:59:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:59:52 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-tQfr7z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:59:52 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)) 06:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:59:52 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-ulu1PL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:59:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:59:52 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-oxhvU0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:59:52 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)) 06:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:59:52 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-CS1Nh0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:59:52 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)) 06:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:59:52 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-l7kA3c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:59:52 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)) 06:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:59:52 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-0OSRfG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:59:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:59:53 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-ZBx5RY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:59:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:59:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:59:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:59:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:59:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:59:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:59:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:59:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:59:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:59:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:59:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:59:55 INFO - Downloading blessings-1.6.tar.gz 06:59:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:59:55 INFO - Installing collected packages: blessings 06:59:55 INFO - Running setup.py install for blessings 06:59:56 INFO - Successfully installed blessings 06:59:56 INFO - Cleaning up... 06:59:56 INFO - Return code: 0 06:59:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:59:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:59:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:59:56 INFO - Reading from file tmpfile_stdout 06:59:56 INFO - Current package versions: 06:59:56 INFO - blessings == 1.6 06:59:56 INFO - blobuploader == 1.2.4 06:59:56 INFO - docopt == 0.6.1 06:59:56 INFO - functools32 == 3.2.3-2 06:59:56 INFO - jsonschema == 2.5.1 06:59:56 INFO - manifestparser == 1.1 06:59:56 INFO - mozInstall == 1.12 06:59:56 INFO - mozcrash == 1.0 06:59:56 INFO - mozdebug == 0.1 06:59:56 INFO - mozdevice == 0.49 06:59:56 INFO - mozfile == 1.2 06:59:56 INFO - mozhttpd == 0.7 06:59:56 INFO - mozinfo == 0.9 06:59:56 INFO - mozleak == 0.1 06:59:56 INFO - mozlog == 3.4 06:59:56 INFO - moznetwork == 0.27 06:59:56 INFO - mozprocess == 0.24 06:59:56 INFO - mozprofile == 0.28 06:59:56 INFO - mozrunner == 6.13 06:59:56 INFO - mozscreenshot == 0.1 06:59:56 INFO - mozsystemmonitor == 0.3 06:59:56 INFO - moztest == 0.8 06:59:56 INFO - mozversion == 1.4 06:59:56 INFO - psutil == 3.1.1 06:59:56 INFO - requests == 1.2.3 06:59:56 INFO - wsgiref == 0.1.2 06:59:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:59:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:59:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:59:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:59:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ea71b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea74768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe709dd40e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e84fd30>, '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 0x10e776db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e844be8>, '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.7ItqocMtKR/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.T1wJJreoFW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 06:59:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 06:59:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:59:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7ItqocMtKR/Render', 06:59:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:59:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:59:56 INFO - 'HOME': '/Users/cltbld', 06:59:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:59:56 INFO - 'LOGNAME': 'cltbld', 06:59:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:56 INFO - 'MOZ_NO_REMOTE': '1', 06:59:56 INFO - 'NO_EM_RESTART': '1', 06:59:56 INFO - 'PAGER': '/bin/cat', 06:59:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:59:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:59:56 INFO - 'PWD': '/builds/slave/test', 06:59:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:59:56 INFO - 'SHELL': '/bin/bash', 06:59:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.T1wJJreoFW/Listeners', 06:59:56 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 06:59:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:59:56 INFO - 'USER': 'cltbld', 06:59:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:59:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:59:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:56 INFO - 'XPC_FLAGS': '0x0', 06:59:56 INFO - 'XPC_SERVICE_NAME': '0', 06:59:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:59:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:59:56 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)) 06:59:56 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)) 06:59:56 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)) 06:59:56 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)) 06:59:56 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)) 06:59:56 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)) 06:59:56 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)) 06:59:56 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)) 06:59:56 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)) 06:59:56 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)) 06:59:56 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)) 06:59:56 INFO - Cleaning up... 06:59:56 INFO - Return code: 0 06:59:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:59:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:59:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:59:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:59:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:56 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 0x10ea71b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea74768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe709dd40e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e84fd30>, '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 0x10e776db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e844be8>, '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.7ItqocMtKR/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.T1wJJreoFW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 06:59:56 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 06:59:56 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 06:59:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7ItqocMtKR/Render', 06:59:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:59:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:59:56 INFO - 'HOME': '/Users/cltbld', 06:59:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:59:56 INFO - 'LOGNAME': 'cltbld', 06:59:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:56 INFO - 'MOZ_NO_REMOTE': '1', 06:59:56 INFO - 'NO_EM_RESTART': '1', 06:59:56 INFO - 'PAGER': '/bin/cat', 06:59:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:59:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:59:56 INFO - 'PWD': '/builds/slave/test', 06:59:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:59:56 INFO - 'SHELL': '/bin/bash', 06:59:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.T1wJJreoFW/Listeners', 06:59:56 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 06:59:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:59:56 INFO - 'USER': 'cltbld', 06:59:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:59:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:59:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:56 INFO - 'XPC_FLAGS': '0x0', 06:59:56 INFO - 'XPC_SERVICE_NAME': '0', 06:59:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:59:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:59:56 INFO - Cleaning up... 06:59:57 INFO - Return code: 0 06:59:57 INFO - Running post-action listener: _resource_record_post_action 06:59:57 INFO - Running post-action listener: _start_resource_monitoring 06:59:57 INFO - Starting resource monitoring. 06:59:57 INFO - [mozharness: 2017-04-10 13:59:57.044665Z] Finished create-virtualenv step (success) 06:59:57 INFO - [mozharness: 2017-04-10 13:59:57.045663Z] Running install step. 06:59:57 INFO - Running pre-action listener: _resource_record_pre_action 06:59:57 INFO - Running main action method: install 06:59:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:59:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:59:57 INFO - Reading from file tmpfile_stdout 06:59:57 INFO - Detecting whether we're running mozinstall >=1.0... 06:59:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:59:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:59:57 INFO - Reading from file tmpfile_stdout 06:59:57 INFO - Output received: 06:59:57 INFO - Usage: mozinstall [options] installer 06:59:57 INFO - Options: 06:59:57 INFO - -h, --help show this help message and exit 06:59:57 INFO - -d DEST, --destination=DEST 06:59:57 INFO - Directory to install application into. [default: 06:59:57 INFO - "/builds/slave/test"] 06:59:57 INFO - --app=APP Application being installed. [default: firefox] 06:59:57 INFO - mkdir: /builds/slave/test/build/application 06:59:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 06:59:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0.en-US.mac.dmg --destination /builds/slave/test/build/application 07:00:11 INFO - Reading from file tmpfile_stdout 07:00:11 INFO - Output received: 07:00:11 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 07:00:11 INFO - Running post-action listener: _resource_record_post_action 07:00:11 INFO - [mozharness: 2017-04-10 14:00:11.858806Z] Finished install step (success) 07:00:11 INFO - [mozharness: 2017-04-10 14:00:11.858959Z] Running run-tests step. 07:00:11 INFO - Running pre-action listener: _resource_record_pre_action 07:00:11 INFO - Running main action method: run_tests 07:00:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:00:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:00:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:00:11 INFO - 2017-04-10 07:00:11.873 screenresolution[1624:7330] starting screenresolution argv=screenresolution get 07:00:11 INFO - 2017-04-10 07:00:11.876 screenresolution[1624:7330] Display 0: 1600x1200x32@60 07:00:11 INFO - 2017-04-10 07:00:11.881 screenresolution[1625:7332] starting screenresolution argv=screenresolution list 07:00:11 INFO - Available Modes on Display 0 07:00:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:00:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:00:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:00:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:00:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:00:12 INFO - Intel Iris: 07:00:12 INFO - Chipset Model: Intel Iris 07:00:12 INFO - Type: GPU 07:00:12 INFO - Bus: Built-In 07:00:12 INFO - VRAM (Dynamic, Max): 1536 MB 07:00:12 INFO - Vendor: Intel (0x8086) 07:00:12 INFO - Device ID: 0x0a2e 07:00:12 INFO - Revision ID: 0x0009 07:00:12 INFO - Displays: 07:00:12 INFO - Display: 07:00:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:00:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:00:12 INFO - Display Serial Number: 1600x1200 60 07:00:12 INFO - Main Display: Yes 07:00:12 INFO - Mirror: Off 07:00:12 INFO - Online: Yes 07:00:12 INFO - Rotation: Supported 07:00:12 INFO - Return code: 0 07:00:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:00:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:00:12 INFO - Python 2.7.3 07:00:12 INFO - Return code: 0 07:00:12 INFO - grabbing minidump binary from tooltool 07:00: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')]} 07:00:12 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 0x10e84fd30>, '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 0x10e776db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e844be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:00:12 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 07:00:12 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 07:00:12 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 07:00:12 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:00:12 INFO - Return code: 0 07:00:12 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:00:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:00:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:00:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:00:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:00:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eHNgSB_US1eINl4ocrUeiQ/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0007', '--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 07:00:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eHNgSB_US1eINl4ocrUeiQ/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0007 --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 07:00:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7ItqocMtKR/Render', 07:00:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:00:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:00:12 INFO - 'HOME': '/Users/cltbld', 07:00:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:00:12 INFO - 'LOGNAME': 'cltbld', 07:00:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:00:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:00:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:12 INFO - 'MOZ_NO_REMOTE': '1', 07:00:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:00:12 INFO - 'NO_EM_RESTART': '1', 07:00:12 INFO - 'PAGER': '/bin/cat', 07:00:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:00:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:12 INFO - 'PWD': '/builds/slave/test', 07:00:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:00:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:00:12 INFO - 'SHELL': '/bin/bash', 07:00:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.T1wJJreoFW/Listeners', 07:00:12 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 07:00:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:00:12 INFO - 'USER': 'cltbld', 07:00:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:00:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:00:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:12 INFO - 'XPC_FLAGS': '0x0', 07:00:12 INFO - 'XPC_SERVICE_NAME': '0', 07:00:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:00:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eHNgSB_US1eINl4ocrUeiQ/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0007', '--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 07:00:12 INFO - mozversion application_buildid: 20170410045748 07:00:12 INFO - mozversion application_changeset: 4f39d509a2e8d0173aa6bff8cf8ecd9d87fac7e4 07:00:12 INFO - mozversion application_display_name: Firefox 07:00:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:00:12 INFO - mozversion application_name: Firefox 07:00:12 INFO - mozversion application_remotingname: firefox 07:00:12 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 07:00:12 INFO - mozversion application_vendor: Mozilla 07:00:12 INFO - mozversion application_version: 53.0 07:00:12 INFO - mozversion platform_buildid: 20170410045748 07:00:12 INFO - mozversion platform_changeset: 4f39d509a2e8d0173aa6bff8cf8ecd9d87fac7e4 07:00:12 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 07:00:12 INFO - mozversion platform_version: 53.0 07:00:12 INFO - using testdate: 1491832812 07:00:12 INFO - actual date: 1491832812 07:00:12 INFO - starting webserver on 'localhost:49241' 07:00:12 INFO - SUITE-START | Running 2 tests 07:00:12 INFO - TEST-START | dromaeo_css 07:00:12 INFO - operating with platform_type : mac_ 07:00:12 INFO - Initialising browser for dromaeo_css test... 07:00:12 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/tmpyxIbTz/profile http://localhost:49241/getInfo.html) 07:00:15 INFO - PROCESS | 1635 | 2017-04-10 07:00:15.291 plugin-container[1638:7507] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e4b, name = 'com.apple.tsm.portname' 07:00:15 INFO - PROCESS | 1635 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:00:15 INFO - PROCESS | 1635 | 2017-04-10 07:00:15.291 plugin-container[1638:7507] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x930f, name = 'com.apple.CFPasteboardClient' 07:00:15 INFO - PROCESS | 1635 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:00:15 INFO - PROCESS | 1635 | 2017-04-10 07:00:15.291 plugin-container[1638:7507] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:00:15 INFO - PROCESS | 1635 | __metrics Screen width/height:1600/1200 07:00:15 INFO - PROCESS | 1635 | colorDepth:24 07:00:15 INFO - PROCESS | 1635 | Browser inner width/height: 1024/689 07:00:15 INFO - PROCESS | 1635 | __metrics 07:00:15 ERROR - PROCESS | 1635 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 07:00:16 INFO - TEST-INFO | 1635: exit 0 07:00:16 INFO - Browser initialized. 07:00:16 INFO - Running cycle 1/1 for dromaeo_css test... 07:00:16 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/tmpyxIbTz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:00:18 INFO - PROCESS | 1639 | 2017-04-10 07:00:18.244 plugin-container[1640:7636] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4347, name = 'com.apple.tsm.portname' 07:00:18 INFO - PROCESS | 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:00:18 INFO - PROCESS | 1639 | 2017-04-10 07:00:18.245 plugin-container[1640:7636] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b0b, name = 'com.apple.CFPasteboardClient' 07:00:18 INFO - PROCESS | 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:00:18 INFO - PROCESS | 1639 | 2017-04-10 07:00:18.245 plugin-container[1640:7636] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:00:27 INFO - PROCESS | 1639 | RSS: Main: 173166592 07:00:27 INFO - PROCESS | 1639 | 07:03:29 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 07:03:31 INFO - PROCESS | 1639 | RSS: Main: 195084288 07:03:31 INFO - PROCESS | 1639 | 07:06:34 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 07:06:34 INFO - PROCESS | 1639 | RSS: Main: 206290944 07:06:34 INFO - PROCESS | 1639 | 07:09:36 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 07:09:37 INFO - PROCESS | 1639 | RSS: Main: 207929344 07:09:37 INFO - PROCESS | 1639 | 07:12:38 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 07:12:39 INFO - PROCESS | 1639 | RSS: Main: 211468288 07:12:39 INFO - PROCESS | 1639 | 07:15:42 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 07:15:42 INFO - PROCESS | 1639 | RSS: Main: 212197376 07:15:42 INFO - PROCESS | 1639 | 07:18:45 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 07:18:45 INFO - PROCESS | 1639 | RSS: Main: 213651456 07:18:45 INFO - PROCESS | 1639 | 07:18:45 INFO - PROCESS | 1639 | __start_tp_report 07:18:45 INFO - PROCESS | 1639 | _x_x_mozilla_page_load 07:18:45 INFO - PROCESS | 1639 | _x_x_mozilla_page_load_details 07:18:45 INFO - PROCESS | 1639 | |i|pagename|runs| 07:18:45 INFO - PROCESS | 1639 | |0;dojo.html;3081.2142903559597;3550.733694972876;3563.6436356364366;3565.3582355176068;3575.8927232183046;5929.703514824258;5966.4928481079105;6004.579679422437;6005;6012.338642749294;5985.221921150255;6063.939360606392;6079.057746049359;6092.482139018178;6116.571839971192;4343.804528796196;5384.7846086156505;5392.110301800199;5445.782168713246;5451.560262098077;4338.5932892047385;5144.511271429208;5450.482204190615;5467.617266791306;5473.480019398151;5293.179557168645;5297.8940421191555;5426.810061647843;5448.618596698233;5463.262459567967;5374.6237763356585;5381.0852155133725;5407.810726624549;5415.323084614423;5492.368377636543;5308.177232528926;5400.459954004607;5406.945930540684;5414.458554144593;5443.537299329561;5868.41315868414;6001.759929602811;6041.72812223451;6124.601900876429;6129.417705317987;6203.844903877439;6212.285587157489;6228.937710622927;6265.216847894013;6309.936900630981;5418.485243901823;6376.936230637727;6391.8402039948905;6394.200724909387;6415.518836087265;6133.325334213233;6143.631382117087;6158.476529494998;6165.260168779775;6181.752729890754;6189.947708889499;6191.349908259568;6384.233891932905;6404.807855764335;6409.903851442232;6208.658523781145;6286.18279623646;6296.968515157395;6297.1813664223355;6306.621602703853;6376.075469056961;6376.7130479128555;6379.617222966637;6379.936200638027;6386.9361306386345;6190.473809726223;6191.19514463117;6199.256089269316;6213.1922850029205;6264.5301602380005;6079.787207447806;6243.157173781572;6255.937440625627;6257.186565746424;6296.150019747275;5171.3535808024;5172.405173405032;5172.7413629319135;5175.508326709032;5209.322788037607;4489.5959363656775;4519.661025423106;4593.54064593538;4633.930491042637;4655.37152484417;6163.753449862045;6210.223722034746;6212.4408803207925;6249.312575616678;6262.467690246289;6346.428821406095;6347.174867267226;6359;6380.298167201604;6399.552031357854;5923.259592550931;6027.638341699512;6104.26748790148;6112.602680825732;6123.387661233841;5606.943930560642;5615.736459296626;5625.831225063254;5629.915551266734;5632.831015069554;6492.350764923564;6504.934950650528;6519.4132528072705;6529.5102867284195;6535.411812936668;6128.625347140727;6198.783042593487;6216.191895053614;6282.780102696383;6298.71655775482;6587.110740050032;6589.505787065893;6604.108445360007;6621.735130594722;6624.635645039376;6303.46420554258;6315.273743519554;6316.589421687576;6320.08358787964;6323.7786677466065;5795.797147099831;6221.09794079865;6227.408396202353;6310.905336420049;6368.012957991518;6152.230971128609;6175.752969881154;6231.906521402273;6245.406686364788;6278.434940855345;5058.696478211319;6194.876102478015;6201.81394558164;6232.688365581612;6238.937610624017;6066.545009124422;6119.654885717031;6131.621347939075;6216.129741836237;6247.625142491465;6146.692665366624;6151.50787936955;6180.289266734203;6236.625802451686;6242.687865606611;6195;6221.191245138103;6232.532560057924;6234.781782637586;6241.438270555672 07:18:45 INFO - PROCESS | 1639 | |1;ext.html;454.7521600727603;477.5224775224775;494.41165013633776;498.26754670634153;560.683213984099;33453;37013.44479832801;40976;42376.788116059455;42474.36288455676;43895;44502.77748611252;44577.77711111448;44656.55343446565;44662.553374466246;9003.459792412476;9211.032841551641;9528.475933823636;9872;9913.256505762061;11946.104042196826;12210.572629957953;12219.327936963464;12311.753764924697;12349;12149.331786751725;12160.027197824153;12168.51325946961;12228.63314100574;12238.632841014783;12014.819777703255;12029.458674359632;12035.879641203563;12051.758964820654;12132.393380330948;11931;11996.880031199664;12014.879851201464;12062.336571488564;12085.939570302093;42791.35812962808;42944.35583466251;43033.92415189614;43152.352714709305;43264.78367608142;4066.877993660195;4117.670586353114;4158.272302347107;4209.7474151551005;4246.193223287565;30356.848215759;30584.388312233852;30629.08112756621;30899;32990.34019319624;3273.6179914293352;3308.503724441329;3393.7115345195443;3451.706604938583;3495.3358861816428;473845;474264;475029;478939;479264;53574;64701.67649161724;64804.02793958;64832.67583662052;65107.02339464912;68367.3163268361;68457.65771171212;68521.62956740937;68545.65727171431;68821.31178688249;17646.117694115244;17886.731699024524;17893.7315940261;17912.820871791115;17933;12527.373631318398;12766.936165319114;13668.453261869414;13755.862441375459;14077.436902523785;18133.27466901309;21388.893055534623;22649.320520384415;22679.86600669993;22821;7888.881666775003;9350.532473376305;9484.525773711286;9545.713628591153;9619.134277915022;863.8963324401112;872.7120050383485;890.3811850763786;908.9545522723837;917.2799352508249;30401;30695;31208.90768823126;31355.90254341087;31424.842875785474;927.1146055516965;1061.2942393308363;1066.2802608239408;1106.6403418888892;1157.8494795676509;12905.677358065936;16267;16308.429204978007;16467.58831029234;16626.83373166253;694553;701368;701846;702355;703787;63920;64449.67775161188;64481.03278450827;64943;65049;1439.5609339151658;1446.8914831387688;1460.8100946876839;1474.483930624273;1479.6744716162427;28785;31176.688233118286;31576;31660.525092123175;31666.208344791565;51779.96440071102;51838;51864.481355187476;52038.219426707874;52103.73948130235;598047;602289;602650;603815;605662;25933.351666208495;26977.920883164454;27559.035433759724;27636.894524218806;45402.72986350603;40598.59401406066;44900.877478062;45785.542144579464;46525.767371162925;46719.29921051119;27886.442271154057;27910.581341280304;27997.160085197476;28357.291067723472;28880.411577363448;30985.845070774503;31006.53490197694;31394.901178458644;31551.684483154873;31812;30471.542926855673;31425.057248281675;37201.44197837089;37264;37293.25413491769;25959.351016224744;27682.584761229;31363.84318078395;31968.200794980312;32226.516602250515;23233.535329293656;23790.762092379548;24015.75984240205;24744.628830567915;24912 07:18:45 INFO - PROCESS | 1639 | |2;jquery.html;362.6572888620255;404.38129661617734;420.0884081543051;422.2505053529984;432.9630534868989;19281.517962050955;20005;20634.6904796428;20716.378508644746;20934.371968840922;22109.889450552764;22278.331650050484;22399.888000560015;22447.887760561214;23233.419164520896;6097.634141951486;6187.4431301182885;6225.128482012522;6236.03341482071;6255.093011513328;5991.340952495244;6152.261728592553;6211.627302361872;6297.149884765567;6318.336574659664;6290.968545157268;6320.083587879754;6350.333215012426;6361.173047503818;6377.936220637804;6428.100065990765;7017.824554386156;7023.262557431498;7023.33278338557;7030.507864449491;6044.063170208625;6182.876342473125;6218;6238.376162383771;6278.340774218733;13254.86745132546;13319.467221311135;14070.08544444618;14215.578442155806;26350.604740928902;2624.39638883058;2628.2772237634613;2640.6435131257226;2690.0584795321674;2744.5745909384077;7047.631406880942;10497.475126243733;10773.299735517245;10905.781884362268;11072.28030178044;1941.2914286285404;1943.9514012149668;1944.6791279438876;1949.6100779843946;1977.4067779666043;137493.3125334367;138514;146784.5321546792;147157;148736.2563187188;9594.66418675343;10306.793864122676;12418.81371779424;12458.252504849737;12762.766515859688;16584.17079146062;16586.502404927873;16592.917035414986;16608.6678266434;16665.91667041657;8960.68637597681;9322.720318390458;9329.953350233205;9364.672236471692;9407.29445291606;7895.131535531087;8687.218150366498;8928.553572321358;9065.048169942193;9185.816283674289;5010;5079.339685840817;5082.745862706924;5084.847454576368;5088.185890257541;1835.8434186462443;2103.0431153824975;2109.683547467892;2147.8174355179985;2157.7410710714817;989.3569180033036;1036.79782442423;1039.0700323210835;1042.760165162017;1082.0856376361962;20562.897185513975;21047.789522104584;21923.232686855885;22033.118675253132;22118.672879627273;1036.6630844975414;1045.5608644369383;1050.2753100360726;1077.5689724110262;1089.455272363818;11191.776164476665;11414.029807466291;11414.657560273039;11426.200165988468;11449.427528623535;708337;720791;770291;770833.1458342673;794091;143015.2849235747;143017.28491357685;143793;146968.26515867352;149065.2546737281;1016.7813920007234;1017.6997785653398;1033.850091736694;1060.9204309676804;1066;20165.899170504053;20275;21106;21167;21274.149034038466;58380.708096459246;60151;60151.79696406135;61355;61518;81217.59391203006;86634;87934.56032719795;88246;90043;8279.544625045439;8344.08215096351;8481.15188481147;8705.21653051203;8894.866577001221;9856.901430985597;12799.168054076456;12942.482300707867;12963.092583519063;13033.543825966046;11086.279391839505;11137.610183643534;11262.436878155895;11582.71043223926;11598.652040438801;7809.297163255334;10142.594296228068;10206.591736330463;10578.259521833397;10602.628907988492;11378.772424551627;11647.941760291144;11658.94170529142;11853.644390668294;11872.821907671565;7506.474546781673;7721.92278077212;8459.534725590152;8495.915040849512;8542.231199191854;11382.658520244406;11389.088872889983;11449.370284634426;11524.654260372203;11776 07:18:45 INFO - PROCESS | 1639 | |3;mootools.html;1467.4643755029417;1489.8808095352372;1499.3927459378951;1504.1877386211447;1509.6829665770188;7749.4962827416175;8018.9198108019045;8260.752177434671;8670.913290867089;8682.479051256922;6513.576617519858;8625.827483450343;8626.698065567707;8632.913670863305;8671.479711217331;2175.8476906616543;2382.65451509531;2440.3045132137345;2441.145599040339;2444.767747064035;2422.079609748302;2448.926532204028;2452.8896199670967;2455.668484754562;2464.37158524576;2405.9518809623796;2412.203972689017;2432.72023717273;2436.5735996200683;2444.4133407982135;2173.5978843913927;2402.6756387887585;2408.3617841272076;2427.635854621812;2431.3313838694326;2250.504888924434;2432.4283793308737;2440.7803297703113;2445.8165637577254;2446.7186273578586;8567.914320856775;8594.87107693385;8656.047834738174;8678.956605216996;8741.912580874174;4458.5318541553315;4766.404199475066;5144.331236939174;5397.190421436777;5405.432429594875;3435.485075555782;3445.879394221215;3507.3862074136923;3550.3609350316933;3589.2283159120916;1215.5867005218267;1238.5231685801032;1265.5886836778084;1299.8375203099613;1305.8237137986441;10999.065079468255;11095.944520277348;11101.222914395996;11107.222494425312;11116.221864469491;4029.3955906613655;4590.1737687215955;4763.904721905612;4788.832390866303;4848.200046992278;9690.46702431373;9709.854352184722;9713.611455541699;9729.805403892024;9744.317897747089;5414.7021913795115;5428.212909128154;5435;5442.482964118402;5443.863903402446;4252.383404406344;4454.910901781946;4514.796834142471;4923.187674033816;4970.950290497049;3410.9317813644084;3990.3216453203027;4038.3134867072667;4105.384192371168;4119.814608342632;1131.4851742457163;1331.966700832487;1339.450825161679;1352.5874608244383;1355.3697530648296;944.471096186138;961.2550273538064;963.6723514005272;975.2636759246865;1015.3704703084135;4718.693284936468;5579.776808927598;5826.2134611827705;6001.1898393717165;6010.9699451502465;603.8399824046631;606.7936901453438;607.9300880398722;611.4466407900857;612.761023200952;3197.7921435106646;3490.3193877194212;3814.809259537012;3908.022994251437;3957.3074711925874;9781.217502599775;9793.314467987315;10240.64157754475;10247.692569222936;10335.793284134275;10224.64213752515;10324.019218174262;10359.63741269052;10384.688459346231;10386.013328733758;8003.319717823933;8134;8202.138775428613;8215.712450064219;8266.710665126691;5906.645601263938;5910.527157827278;5945.702714864153;6070.028795392893;6121.540884433774;7895.68417263303;9488.810223795623;9517.238620910171;9579.185769209416;9686.128248457673;9137.451752894847;9451.338406311492;9510.904890951279;9628.277879158952;9657.034296570288;6800.217974932748;7011.053507776385;7151.785446436407;7313.634318284171;7472.701091956261;7919.2872641462545;8174.754757357289;8213.342932565261;8218.835623287381;8226.958865205635;7091.290870912868;7226.4218862491925;7254.818629534304;7287.963560182166;7352.154502232098;7228.602426866572;7351.522151060164;7366.189719130784;7372.7050917964825;7518.173000969999;6346.841328966812;6479.222493300834;6493.545451818516;6503.869922601427;6505.121808555785;5078.746062696924;5114.641975061859;5154.7938082476285;5259.60552958522;5330.440303768049;5106.839943920109;5177;5274.050670879278;5406.810761623325;5408.512659018801 07:18:45 INFO - PROCESS | 1639 | |4;prototype.html;327.82133737113276;383.97312188146833;385.56431232707035;391.9764814111152;395.76254247451516;4851.1025460289875;5429.425466614682;5536.228406909785;5552.5280351170095;5593.244911936892;4539.909201815962;4731.952680473194;4885.364902562671;5092.261622064799;5331.294750148648;4229.885057471264;4292.574695297163;4308.97845510772;4317.301686445971;4351.934720979172;4155.958440415602;4337.674674399417;4343.2182207202695;4348.456442944632;4379.948812285061;4112.527059388164;4309.461317335333;4315.244832154361;4328.761918094504;4346.282863327548;3676.283124790667;4068.7825135301036;4175.394567787669;4264.424302719124;4269.359596060584;3510.80690562019;3634.3821550336506;3796.8481260749536;3809.2000679857265;3817.3510503214243;5354.170103633943;5355.3305836770405;5365.765873848997;5389.73051347435;5397.001554712351;4275.337322714984;4808.994378513429;4965.379327584052;5031.396232452093;5032.370953630796;4915.631327650441;5600.943990560083;5858.455634341248;5885.176075349455;5891.911621325684;3742.3825068863875;3811.5045044144363;4253.659707223445;4267.701260911737;4281.293586558214;5208.817691380784;5669.23465332179;6167.87664246717;6186.350433204494;6214.782482613087;4310.202612516632;4311.913761724748;4326.394304797331;4339.500957389941;4355.128974205171;3738.9626103738615;4405.140997505519;4405.889852753707;4422.513523512411;4444.044530425909;4236.533981262059;4924.863114983431;4981.302617633534;5037.345145131183;5056.9494305057215;5864.914990726729;5882.264746892715;5889.5582831286965;5894.67579283135;5941.792037278761;1277.7222777222778;1293.5964478540889;1416.362636813438;1455.9126452412677;1468.9853101469062;778.1051790440926;889.0886840988039;907.7004588485784;1015.4161357219481;1017.5624481473037;4961.975190124026;5126.871828204325;5326.573874090063;5341.172118321666;5364.892702145935;5064.392272927199;5387.299651045339;5559.610097475631;5711.343195532484;5802.79690210849;4611.708721557902;4692.601128904082;4748.1956856394345;5093.312402825645;5313.867153321198;2634.4335967767024;2653.7346265373308;2668.679758429001;3068.861901214451;3070.401271752032;6066.483379155211;6068.180795592627;6072.51419886408;6074.268833382464;6089.112375163713;5640.943590564042;5853.560982926298;5927.5993222744855;5952.898713737973;5971;4924.3654644764165;5311.6986338345805;5700.857478563069;6128.785492507741;6128.969355153285;5752.338481074563;6061.878762424815;6101.176341193882;6117.877642447037;6120.163950814649;5459.481349271813;5658.943410565842;5931.3178984417345;5987.371326010881;5993.910091348546;5584.497395234448;6168.568200226121;6222.719977600928;6257.99360511598;6312.526560508072;3310.5365248864696;3683.0424089736325;3701.8704345347783;4047.959520404876;4057.2494088593703;5246.921296180637;5707.286589176353;5788.989725342714;6016.8784382697995;6043.093535969464;5183.974080129575;5228.71242081674;5412.512873841373;5871.975932394735;5894.616849904743;4663.603593694438;5650.704590947786;5740.827775166752;5868.501177399798;5891.852703682443;4886.462489126265;5780.7398667060925;5807.651540907559;5835.2122463466885;5840.065589505659;5932.673702946379;5941.940580594139;5964.850878728066;5998.890205312031;6011.338752737108;5137.794488220429;5415.296011518635;5701.971490142523;5738.799142030009;5813.4013146383395 07:18:45 INFO - PROCESS | 1639 | |5;yui.html;718.5724493926116;726.7165805335917;772.6021099133947;840.0465471689632;843.4348986179261;17618.383356582523;18370.081495925217;18407.07964601771;18434.907825460872;18488.35290764822;16624.919380240277;17637.206325715342;17761.20074596643;17874.28502859887;17958;718.5652680128526;875.2778957360172;891.7235656946367;895.0512456795785;911.8404279251138;908.7546362482126;909.9772505687345;910.9498977556232;913.5158366065996;913.6208473483497;946.4463288975958;954.4321128928276;955;955.2119501411329;957.2533423929311;939.1172298039821;951.1392190068;954.3271993244781;954.5275088831038;955.6034245787989;694.3265032918061;696.8919817428307;697.3793323941696;709.6806437103324;710.3251910684818;15969.520914372471;15982.76025859613;16351.672966540722;16602;16966.40617578391;14469.78295325571;14507.347169377403;14599;14650.780238296327;14710.852891471162;11804.881951180465;12002;12014.159008869383;12080.818787718192;12630.368481575884;3893.7274390792654;3906.433567132778;4000.959990400117;4028.174224284044;4037.9394309085387;115098;115350;116680;117089.41455292754;119040;11142.721431964104;11228.831567526493;11283.605073822377;11336.773264534662;12126.636200913987;22119.225827095976;22869.97085131173;23207;23431.7656823433;23442.413939651644;7864.606769661608;8214.63034163464;8274.29668478174;8286.047104582929;8375.623096960651;4406.383106365111;4411.536788637211;4467.597916187558;4506.977465112719;4513.210188217115;3746.625337466286;3793.3551296279697;3841.9231615368094;3845.615438456188;3855.2289542091694;700.6881937537848;710.6411262312499;718.3750137380408;718.9898193038789;719.650655021834;688.2944981394111;691.3294104718415;712.4529805943772;728.5483000539593;744.1776836595592;9629.422234665943;10569.67879015123;10575.524101415454;10594.739321218702;10905.890941090645;697.5570512724355;716.451914285572;732.9120505539263;734.5262305812828;734.5482528245091;4809.470958194595;5122.615803814729;5141.794328226829;5152.330197074356;5152.690838549699;105517.94482055235;107926.3811042835;110061.44969275102;114025;115695.42152289185;91790;96113.51943240239;98230;99952;100393;78610.60694696604;79096.81354779568;80376;81835;81835.5908220455;9688.9031109688;9818.410895346302;9890.406575605199;9952.950235248778;9953.950230248802;55688.16467753068;56129.71935140298;56349.43650563606;56762.432375675715;57112.71443642755;71151.9327210082;72331.27668723246;73748;73824;76793.2320676786;11740.471678774305;11783.410829458664;11851.881481185077;12143;12451.501939922664;12888.871111288767;13126.409311581192;13134.60596182116;13365.53220637273;13403.994700397314;12013.939930300292;12086.456109474919;12256.448459819152;12531.934785542966;12751.489940402651;12042.397880105784;12430.627081187216;12640.6839829005;12681.556145534862;12716.491340346283;11708;12115.15193936416;12120.818187727367;12122.939385303018;12184.476940382452;7133.643317833984;7378.372838308804;7536.4615575089765;7662.080550333995;7724.459287849797;8966.86549701742;9080.40977336471;9966.352187107816;10003.2997690161;10032.749181270527 07:18:45 INFO - PROCESS | 1639 | __end_tp_report 07:18:45 INFO - PROCESS | 1639 | __start_cc_report 07:18:45 INFO - PROCESS | 1639 | _x_x_mozilla_cycle_collect,386 07:18:45 INFO - PROCESS | 1639 | __end_cc_report 07:18:45 INFO - PROCESS | 1639 | __startTimestamp1491833925907__endTimestamp 07:18:45 INFO - PROCESS | 1639 | 07:18:45 INFO - PROCESS | 1639 | ------- Summary: start ------- 07:18:45 INFO - PROCESS | 1639 | Number of tests: 6 07:18:45 INFO - PROCESS | 1639 | 07:18:45 INFO - PROCESS | 1639 | [#0] dojo.html Cycles:165 Average:5902.60 Median:6180.29 stddev:651.83 (10.5%) stddev-sans-first:615.11 07:18:45 INFO - PROCESS | 1639 | Values: 3081.2 3550.7 3563.6 3565.4 3575.9 5929.7 5966.5 6004.6 6005.0 6012.3 5985.2 6063.9 6079.1 6092.5 6116.6 4343.8 5384.8 5392.1 5445.8 5451.6 4338.6 5144.5 5450.5 5467.6 5473.5 5293.2 5297.9 5426.8 5448.6 5463.3 5374.6 5381.1 5407.8 5415.3 5492.4 5308.2 5400.5 5406.9 5414.5 5443.5 5868.4 6001.8 6041.7 6124.6 6129.4 6203.8 6212.3 6228.9 6265.2 6309.9 5418.5 6376.9 6391.8 6394.2 6415.5 6133.3 6143.6 6158.5 6165.3 6181.8 6189.9 6191.3 6384.2 6404.8 6409.9 6208.7 6286.2 6297.0 6297.2 6306.6 6376.1 6376.7 6379.6 6379.9 6386.9 6190.5 6191.2 6199.3 6213.2 6264.5 6079.8 6243.2 6255.9 6257.2 6296.2 5171.4 5172.4 5172.7 5175.5 5209.3 4489.6 4519.7 4593.5 4633.9 4655.4 6163.8 6210.2 6212.4 6249.3 6262.5 6346.4 6347.2 6359.0 6380.3 6399.6 5923.3 6027.6 6104.3 6112.6 6123.4 5606.9 5615.7 5625.8 5629.9 5632.8 6492.4 6504.9 6519.4 6529.5 6535.4 6128.6 6198.8 6216.2 6282.8 6298.7 6587.1 6589.5 6604.1 6621.7 6624.6 6303.5 6315.3 6316.6 6320.1 6323.8 5795.8 6221.1 6227.4 6310.9 6368.0 6152.2 6175.8 6231.9 6245.4 6278.4 5058.7 6194.9 6201.8 6232.7 6238.9 6066.5 6119.7 6131.6 6216.1 6247.6 6146.7 6151.5 6180.3 6236.6 6242.7 6195.0 6221.2 6232.5 6234.8 6241.4 07:18:45 INFO - PROCESS | 1639 | 07:18:45 INFO - PROCESS | 1639 | [#1] ext.html Cycles:180 Average:72721.25 Median:18149.42 stddev:160641.41 (885.1%) stddev-sans-first:161000.42 07:18:45 INFO - PROCESS | 1639 | Values: 454.8 477.5 494.4 498.3 560.7 33453.0 37013.4 40976.0 42376.8 42474.4 43895.0 44502.8 44577.8 44656.6 44662.6 9003.5 9211.0 9528.5 9872.0 9913.3 11946.1 12210.6 12219.3 12311.8 12349.0 12149.3 12160.0 12168.5 12228.6 12238.6 12014.8 12029.5 12035.9 12051.8 12132.4 11931.0 11996.9 12014.9 12062.3 12085.9 42791.4 42944.4 43033.9 43152.4 43264.8 4066.9 4117.7 4158.3 4209.7 4246.2 30356.8 30584.4 30629.1 30899.0 32990.3 3273.6 3308.5 3393.7 3451.7 3495.3 473845.0 474264.0 475029.0 478939.0 479264.0 53574.0 64701.7 64804.0 64832.7 65107.0 68367.3 68457.7 68521.6 68545.7 68821.3 17646.1 17886.7 17893.7 17912.8 17933.0 12527.4 12766.9 13668.5 13755.9 14077.4 18133.3 21388.9 22649.3 22679.9 22821.0 7888.9 9350.5 9484.5 9545.7 9619.1 863.9 872.7 890.4 909.0 917.3 30401.0 30695.0 31208.9 31355.9 31424.8 927.1 1061.3 1066.3 1106.6 1157.8 12905.7 16267.0 16308.4 16467.6 16626.8 694553.0 701368.0 701846.0 702355.0 703787.0 63920.0 64449.7 64481.0 64943.0 65049.0 1439.6 1446.9 1460.8 1474.5 1479.7 28785.0 31176.7 31576.0 31660.5 31666.2 51780.0 51838.0 51864.5 52038.2 52103.7 598047.0 602289.0 602650.0 603815.0 605662.0 25933.4 26977.9 27559.0 27636.9 45402.7 40598.6 44900.9 45785.5 46525.8 46719.3 27886.4 27910.6 27997.2 28357.3 28880.4 30985.8 31006.5 31394.9 31551.7 31812.0 30471.5 31425.1 37201.4 37264.0 37293.3 25959.4 27682.6 31363.8 31968.2 32226.5 23233.5 23790.8 24015.8 24744.6 24912.0 07:18:45 INFO - PROCESS | 1639 | 07:18:45 INFO - PROCESS | 1639 | [#2] jquery.html Cycles:180 Average:41066.66 Median:12040.49 stddev:125522.54 (1042.5%) stddev-sans-first:125837.45 07:18:45 INFO - PROCESS | 1639 | Values: 362.7 404.4 420.1 422.3 433.0 19281.5 20005.0 20634.7 20716.4 20934.4 22109.9 22278.3 22399.9 22447.9 23233.4 6097.6 6187.4 6225.1 6236.0 6255.1 5991.3 6152.3 6211.6 6297.1 6318.3 6291.0 6320.1 6350.3 6361.2 6377.9 6428.1 7017.8 7023.3 7023.3 7030.5 6044.1 6182.9 6218.0 6238.4 6278.3 13254.9 13319.5 14070.1 14215.6 26350.6 2624.4 2628.3 2640.6 2690.1 2744.6 7047.6 10497.5 10773.3 10905.8 11072.3 1941.3 1944.0 1944.7 1949.6 1977.4 137493.3 138514.0 146784.5 147157.0 148736.3 9594.7 10306.8 12418.8 12458.3 12762.8 16584.2 16586.5 16592.9 16608.7 16665.9 8960.7 9322.7 9330.0 9364.7 9407.3 7895.1 8687.2 8928.6 9065.0 9185.8 5010.0 5079.3 5082.7 5084.8 5088.2 1835.8 2103.0 2109.7 2147.8 2157.7 989.4 1036.8 1039.1 1042.8 1082.1 20562.9 21047.8 21923.2 22033.1 22118.7 1036.7 1045.6 1050.3 1077.6 1089.5 11191.8 11414.0 11414.7 11426.2 11449.4 708337.0 720791.0 770291.0 770833.1 794091.0 143015.3 143017.3 143793.0 146968.3 149065.3 1016.8 1017.7 1033.9 1060.9 1066.0 20165.9 20275.0 21106.0 21167.0 21274.1 58380.7 60151.0 60151.8 61355.0 61518.0 81217.6 86634.0 87934.6 88246.0 90043.0 8279.5 8344.1 8481.2 8705.2 8894.9 9856.9 12799.2 12942.5 12963.1 13033.5 11086.3 11137.6 11262.4 11582.7 11598.7 7809.3 10142.6 10206.6 10578.3 10602.6 11378.8 11647.9 11658.9 11853.6 11872.8 7506.5 7721.9 8459.5 8495.9 8542.2 11382.7 11389.1 11449.4 11524.7 11776.0 07:18:45 INFO - PROCESS | 1639 | 07:18:45 INFO - PROCESS | 1639 | [#3] mootools.html Cycles:180 Average:5560.00 Median:5363.82 stddev:3037.99 (56.6%) stddev-sans-first:3030.94 07:18:45 INFO - PROCESS | 1639 | Values: 1467.5 1489.9 1499.4 1504.2 1509.7 7749.5 8018.9 8260.8 8670.9 8682.5 6513.6 8625.8 8626.7 8632.9 8671.5 2175.8 2382.7 2440.3 2441.1 2444.8 2422.1 2448.9 2452.9 2455.7 2464.4 2406.0 2412.2 2432.7 2436.6 2444.4 2173.6 2402.7 2408.4 2427.6 2431.3 2250.5 2432.4 2440.8 2445.8 2446.7 8567.9 8594.9 8656.0 8679.0 8741.9 4458.5 4766.4 5144.3 5397.2 5405.4 3435.5 3445.9 3507.4 3550.4 3589.2 1215.6 1238.5 1265.6 1299.8 1305.8 10999.1 11095.9 11101.2 11107.2 11116.2 4029.4 4590.2 4763.9 4788.8 4848.2 9690.5 9709.9 9713.6 9729.8 9744.3 5414.7 5428.2 5435.0 5442.5 5443.9 4252.4 4454.9 4514.8 4923.2 4971.0 3410.9 3990.3 4038.3 4105.4 4119.8 1131.5 1332.0 1339.5 1352.6 1355.4 944.5 961.3 963.7 975.3 1015.4 4718.7 5579.8 5826.2 6001.2 6011.0 603.8 606.8 607.9 611.4 612.8 3197.8 3490.3 3814.8 3908.0 3957.3 9781.2 9793.3 10240.6 10247.7 10335.8 10224.6 10324.0 10359.6 10384.7 10386.0 8003.3 8134.0 8202.1 8215.7 8266.7 5906.6 5910.5 5945.7 6070.0 6121.5 7895.7 9488.8 9517.2 9579.2 9686.1 9137.5 9451.3 9510.9 9628.3 9657.0 6800.2 7011.1 7151.8 7313.6 7472.7 7919.3 8174.8 8213.3 8218.8 8227.0 7091.3 7226.4 7254.8 7288.0 7352.2 7228.6 7351.5 7366.2 7372.7 7518.2 6346.8 6479.2 6493.5 6503.9 6505.1 5078.7 5114.6 5154.8 5259.6 5330.4 5106.8 5177.0 5274.1 5406.8 5408.5 07:18:45 INFO - PROCESS | 1639 | 07:18:45 INFO - PROCESS | 1639 | [#4] prototype.html Cycles:180 Average:4737.86 Median:5218.77 stddev:1433.15 (27.5%) stddev-sans-first:1398.42 07:18:45 INFO - PROCESS | 1639 | Values: 327.8 384.0 385.6 392.0 395.8 4851.1 5429.4 5536.2 5552.5 5593.2 4539.9 4732.0 4885.4 5092.3 5331.3 4229.9 4292.6 4309.0 4317.3 4351.9 4156.0 4337.7 4343.2 4348.5 4379.9 4112.5 4309.5 4315.2 4328.8 4346.3 3676.3 4068.8 4175.4 4264.4 4269.4 3510.8 3634.4 3796.8 3809.2 3817.4 5354.2 5355.3 5365.8 5389.7 5397.0 4275.3 4809.0 4965.4 5031.4 5032.4 4915.6 5600.9 5858.5 5885.2 5891.9 3742.4 3811.5 4253.7 4267.7 4281.3 5208.8 5669.2 6167.9 6186.4 6214.8 4310.2 4311.9 4326.4 4339.5 4355.1 3739.0 4405.1 4405.9 4422.5 4444.0 4236.5 4924.9 4981.3 5037.3 5056.9 5864.9 5882.3 5889.6 5894.7 5941.8 1277.7 1293.6 1416.4 1455.9 1469.0 778.1 889.1 907.7 1015.4 1017.6 4962.0 5126.9 5326.6 5341.2 5364.9 5064.4 5387.3 5559.6 5711.3 5802.8 4611.7 4692.6 4748.2 5093.3 5313.9 2634.4 2653.7 2668.7 3068.9 3070.4 6066.5 6068.2 6072.5 6074.3 6089.1 5640.9 5853.6 5927.6 5952.9 5971.0 4924.4 5311.7 5700.9 6128.8 6129.0 5752.3 6061.9 6101.2 6117.9 6120.2 5459.5 5658.9 5931.3 5987.4 5993.9 5584.5 6168.6 6222.7 6258.0 6312.5 3310.5 3683.0 3701.9 4048.0 4057.2 5246.9 5707.3 5789.0 6016.9 6043.1 5184.0 5228.7 5412.5 5872.0 5894.6 4663.6 5650.7 5740.8 5868.5 5891.9 4886.5 5780.7 5807.7 5835.2 5840.1 5932.7 5941.9 5964.9 5998.9 6011.3 5137.8 5415.3 5702.0 5738.8 5813.4 07:18:45 INFO - PROCESS | 1639 | 07:18:45 INFO - PROCESS | 1639 | [#5] yui.html Cycles:180 Average:21682.51 Median:4510.09 stddev:32009.58 (709.7%) stddev-sans-first:32060.67 07:18:45 INFO - PROCESS | 1639 | Values: 718.6 726.7 772.6 840.0 843.4 17618.4 18370.1 18407.1 18434.9 18488.4 16624.9 17637.2 17761.2 17874.3 17958.0 718.6 875.3 891.7 895.1 911.8 908.8 910.0 910.9 913.5 913.6 946.4 954.4 955.0 955.2 957.3 939.1 951.1 954.3 954.5 955.6 694.3 696.9 697.4 709.7 710.3 15969.5 15982.8 16351.7 16602.0 16966.4 14469.8 14507.3 14599.0 14650.8 14710.9 11804.9 12002.0 12014.2 12080.8 12630.4 3893.7 3906.4 4001.0 4028.2 4037.9 115098.0 115350.0 116680.0 117089.4 119040.0 11142.7 11228.8 11283.6 11336.8 12126.6 22119.2 22870.0 23207.0 23431.8 23442.4 7864.6 8214.6 8274.3 8286.0 8375.6 4406.4 4411.5 4467.6 4507.0 4513.2 3746.6 3793.4 3841.9 3845.6 3855.2 700.7 710.6 718.4 719.0 719.7 688.3 691.3 712.5 728.5 744.2 9629.4 10569.7 10575.5 10594.7 10905.9 697.6 716.5 732.9 734.5 734.5 4809.5 5122.6 5141.8 5152.3 5152.7 105517.9 107926.4 110061.4 114025.0 115695.4 91790.0 96113.5 98230.0 99952.0 100393.0 78610.6 79096.8 80376.0 81835.0 81835.6 9688.9 9818.4 9890.4 9953.0 9954.0 55688.2 56129.7 56349.4 56762.4 57112.7 71151.9 72331.3 73748.0 73824.0 76793.2 11740.5 11783.4 11851.9 12143.0 12451.5 12888.9 13126.4 13134.6 13365.5 13404.0 12013.9 12086.5 12256.4 12531.9 12751.5 12042.4 12430.6 12640.7 12681.6 12716.5 11708.0 12115.2 12120.8 12122.9 12184.5 7133.6 7378.4 7536.5 7662.1 7724.5 8966.9 9080.4 9966.4 10003.3 10032.7 07:18:45 INFO - PROCESS | 1639 | -------- Summary: end -------- 07:18:45 INFO - PROCESS | 1639 | 07:18:46 INFO - TEST-INFO | 1639: exit 0 07:18:46 INFO - TEST-OK | dromaeo_css | took 1114010ms 07:18:46 INFO - TEST-START | kraken 07:18:46 INFO - operating with platform_type : mac_ 07:18:46 INFO - Initialising browser for kraken test... 07:18:46 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/tmpi99kJP/profile http://localhost:49241/getInfo.html) 07:18:49 INFO - PROCESS | 1651 | 2017-04-10 07:18:49.157 plugin-container[1654:9920] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8443, name = 'com.apple.tsm.portname' 07:18:49 INFO - PROCESS | 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:18:49 INFO - PROCESS | 1651 | 2017-04-10 07:18:49.157 plugin-container[1654:9920] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x881b, name = 'com.apple.CFPasteboardClient' 07:18:49 INFO - PROCESS | 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:18:49 INFO - PROCESS | 1651 | 2017-04-10 07:18:49.157 plugin-container[1654:9920] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:18:49 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 07:18:49 INFO - PROCESS | 1651 | colorDepth:24 07:18:49 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 07:18:49 INFO - PROCESS | 1651 | __metrics 07:18:49 ERROR - PROCESS | 1651 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 07:18:50 INFO - TEST-INFO | 1651: exit 0 07:18:50 INFO - Browser initialized. 07:18:50 INFO - Running cycle 1/1 for kraken test... 07:18:50 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/tmpi99kJP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:18:52 INFO - PROCESS | 1655 | 2017-04-10 07:18:52.426 plugin-container[1656:10034] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4347, name = 'com.apple.tsm.portname' 07:18:52 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:18:52 INFO - PROCESS | 1655 | 2017-04-10 07:18:52.427 plugin-container[1656:10034] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b0b, name = 'com.apple.CFPasteboardClient' 07:18:52 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:18:52 INFO - PROCESS | 1655 | 2017-04-10 07:18:52.427 plugin-container[1656:10034] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:19:02 INFO - PROCESS | 1655 | RSS: Main: 173015040 07:19:02 INFO - PROCESS | 1655 | 07:19:05 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 07:19:06 INFO - PROCESS | 1655 | RSS: Main: 185765888 07:19:06 INFO - PROCESS | 1655 | 07:19:08 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 07:19:09 INFO - PROCESS | 1655 | RSS: Main: 193708032 07:19:09 INFO - PROCESS | 1655 | 07:19:12 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 07:19:13 INFO - PROCESS | 1655 | RSS: Main: 197517312 07:19:13 INFO - PROCESS | 1655 | 07:19:15 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 07:19:15 INFO - PROCESS | 1655 | RSS: Main: 197738496 07:19:15 INFO - PROCESS | 1655 | 07:19:17 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:19:18 INFO - PROCESS | 1655 | RSS: Main: 197758976 07:19:18 INFO - PROCESS | 1655 | 07:19:21 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 07:19:22 INFO - PROCESS | 1655 | RSS: Main: 201814016 07:19:22 INFO - PROCESS | 1655 | 07:19:25 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 07:19:25 INFO - PROCESS | 1655 | RSS: Main: 202760192 07:19:25 INFO - PROCESS | 1655 | 07:19:28 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 07:19:29 INFO - PROCESS | 1655 | RSS: Main: 202936320 07:19:29 INFO - PROCESS | 1655 | 07:19:30 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:19:31 INFO - PROCESS | 1655 | RSS: Main: 201764864 07:19:31 INFO - PROCESS | 1655 | 07:19:33 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:19:33 INFO - PROCESS | 1655 | RSS: Main: 201793536 07:19:33 INFO - PROCESS | 1655 | 07:19:35 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:19:36 INFO - PROCESS | 1655 | RSS: Main: 201764864 07:19:36 INFO - PROCESS | 1655 | 07:19:39 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:19:40 INFO - PROCESS | 1655 | RSS: Main: 202006528 07:19:40 INFO - PROCESS | 1655 | 07:19:43 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:19:43 INFO - PROCESS | 1655 | RSS: Main: 202416128 07:19:43 INFO - PROCESS | 1655 | 07:19:45 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 07:19:45 INFO - PROCESS | 1655 | RSS: Main: 204476416 07:19:45 INFO - PROCESS | 1655 | 07:19:45 INFO - PROCESS | 1655 | __start_tp_report 07:19:45 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 07:19:45 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 07:19:45 INFO - PROCESS | 1655 | |i|pagename|runs| 07:19:45 INFO - PROCESS | 1655 | |0;ai-astar;105;118;119;115;114;99;163;173;99;157 07:19:45 INFO - PROCESS | 1655 | |1;audio-beat-detection;176;139;143;146;110;109;102;139;158;111 07:19:45 INFO - PROCESS | 1655 | |2;audio-dft;198;195;195;197;198;197;232;196;193;197 07:19:45 INFO - PROCESS | 1655 | |3;audio-fft;78;74;81;83;56;73;52;49;63;50 07:19:45 INFO - PROCESS | 1655 | |4;audio-oscillator;91;68;81;70;69;70;81;69;71;85 07:19:45 INFO - PROCESS | 1655 | |5;imaging-gaussian-blur;89;87;110;84;127;99;92;122;89;114 07:19:45 INFO - PROCESS | 1655 | |6;imaging-darkroom;112;122;96;98;113;98;98;105;97;99 07:19:45 INFO - PROCESS | 1655 | |7;imaging-desaturate;140;126;98;92;91;93;91;90;93;92 07:19:45 INFO - PROCESS | 1655 | |8;json-parse-financial;58;60;58;62;63;64;63;64;62;62 07:19:45 INFO - PROCESS | 1655 | |9;json-stringify-tinderbox;64;65;80;77;71;69;69;69;70;70 07:19:45 INFO - PROCESS | 1655 | |10;stanford-crypto-aes;84;86;86;82;80;84;82;89;88;88 07:19:45 INFO - PROCESS | 1655 | |11;stanford-crypto-ccm;132;135;136;145;154;149;147;154;184;137 07:19:45 INFO - PROCESS | 1655 | |12;stanford-crypto-pbkdf2;164;165;165;166;165;166;164;170;164;179 07:19:45 INFO - PROCESS | 1655 | |13;stanford-crypto-sha256-iterative;66;66;66;61;64;64;66;64;66;67 07:19:45 INFO - PROCESS | 1655 | __end_tp_report 07:19:45 INFO - PROCESS | 1655 | __start_cc_report 07:19:45 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,943 07:19:45 INFO - PROCESS | 1655 | __end_cc_report 07:19:45 INFO - PROCESS | 1655 | __startTimestamp1491833985553__endTimestamp 07:19:45 INFO - PROCESS | 1655 | 07:19:45 INFO - PROCESS | 1655 | ------- Summary: start ------- 07:19:45 INFO - PROCESS | 1655 | Number of tests: 14 07:19:45 INFO - PROCESS | 1655 | 07:19:45 INFO - PROCESS | 1655 | [#0] ai-astar Cycles:10 Average:126.20 Median:160.00 stddev:27.52 (17.2%) stddev-sans-first:28.10 07:19:45 INFO - PROCESS | 1655 | Values: 105.0 118.0 119.0 115.0 114.0 99.0 163.0 173.0 99.0 157.0 07:19:45 INFO - PROCESS | 1655 | 07:19:45 INFO - PROCESS | 1655 | [#1] audio-beat-detection Cycles:10 Average:133.30 Median:141.00 stddev:24.41 (17.3%) stddev-sans-first:20.43 07:19:45 INFO - PROCESS | 1655 | Values: 176.0 139.0 143.0 146.0 110.0 109.0 102.0 139.0 158.0 111.0 07:19:45 INFO - PROCESS | 1655 | 07:19:45 INFO - PROCESS | 1655 | [#2] audio-dft Cycles:10 Average:199.80 Median:197.00 stddev:11.42 (5.8%) stddev-sans-first:12.09 07:19:45 INFO - PROCESS | 1655 | Values: 198.0 195.0 195.0 197.0 198.0 197.0 232.0 196.0 193.0 197.0 07:19:45 INFO - PROCESS | 1655 | 07:19:45 INFO - PROCESS | 1655 | [#3] audio-fft Cycles:10 Average:65.90 Median:73.50 stddev:13.42 (18.3%) stddev-sans-first:13.50 07:19:45 INFO - PROCESS | 1655 | Values: 78.0 74.0 81.0 83.0 56.0 73.0 52.0 49.0 63.0 50.0 07:19:45 INFO - PROCESS | 1655 | 07:19:45 INFO - PROCESS | 1655 | [#4] audio-oscillator Cycles:10 Average:75.50 Median:76.00 stddev:8.25 (10.9%) stddev-sans-first:6.57 07:19:45 INFO - PROCESS | 1655 | Values: 91.0 68.0 81.0 70.0 69.0 70.0 81.0 69.0 71.0 85.0 07:19:45 INFO - PROCESS | 1655 | 07:19:45 INFO - PROCESS | 1655 | [#5] imaging-gaussian-blur Cycles:10 Average:101.30 Median:88.00 stddev:15.72 (17.9%) stddev-sans-first:16.03 07:19:45 INFO - PROCESS | 1655 | Values: 89.0 87.0 110.0 84.0 127.0 99.0 92.0 122.0 89.0 114.0 07:19:45 INFO - PROCESS | 1655 | 07:19:45 INFO - PROCESS | 1655 | [#6] imaging-darkroom Cycles:10 Average:103.80 Median:97.50 stddev:8.92 (9.1%) stddev-sans-first:8.95 07:19:45 INFO - PROCESS | 1655 | Values: 112.0 122.0 96.0 98.0 113.0 98.0 98.0 105.0 97.0 99.0 07:19:45 INFO - PROCESS | 1655 | 07:19:45 INFO - PROCESS | 1655 | [#7] imaging-desaturate Cycles:10 Average:100.60 Median:92.00 stddev:17.53 (19.0%) stddev-sans-first:11.40 07:19:45 INFO - PROCESS | 1655 | Values: 140.0 126.0 98.0 92.0 91.0 93.0 91.0 90.0 93.0 92.0 07:19:45 INFO - PROCESS | 1655 | 07:19:45 INFO - PROCESS | 1655 | [#8] json-parse-financial Cycles:10 Average:61.60 Median:62.50 stddev:2.22 (3.6%) stddev-sans-first:1.94 07:19:45 INFO - PROCESS | 1655 | Values: 58.0 60.0 58.0 62.0 63.0 64.0 63.0 64.0 62.0 62.0 07:19:45 INFO - PROCESS | 1655 | 07:19:45 INFO - PROCESS | 1655 | [#9] json-stringify-tinderbox Cycles:10 Average:70.40 Median:70.00 stddev:4.86 (6.9%) stddev-sans-first:4.57 07:19:45 INFO - PROCESS | 1655 | Values: 64.0 65.0 80.0 77.0 71.0 69.0 69.0 69.0 70.0 70.0 07:19:45 INFO - PROCESS | 1655 | 07:19:45 INFO - PROCESS | 1655 | [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:86.00 stddev:3.00 (3.5%) stddev-sans-first:3.16 07:19:45 INFO - PROCESS | 1655 | Values: 84.0 86.0 86.0 82.0 80.0 84.0 82.0 89.0 88.0 88.0 07:19:45 INFO - PROCESS | 1655 | 07:19:45 INFO - PROCESS | 1655 | [#11] stanford-crypto-ccm Cycles:10 Average:147.30 Median:148.00 stddev:15.14 (10.2%) stddev-sans-first:15.02 07:19:45 INFO - PROCESS | 1655 | Values: 132.0 135.0 136.0 145.0 154.0 149.0 147.0 154.0 184.0 137.0 07:19:45 INFO - PROCESS | 1655 | 07:19:45 INFO - PROCESS | 1655 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.80 Median:165.50 stddev:4.64 (2.8%) stddev-sans-first:4.81 07:19:45 INFO - PROCESS | 1655 | Values: 164.0 165.0 165.0 166.0 165.0 166.0 164.0 170.0 164.0 179.0 07:19:45 INFO - PROCESS | 1655 | 07:19:45 INFO - PROCESS | 1655 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.00 Median:66.00 stddev:1.76 (2.7%) stddev-sans-first:1.83 07:19:45 INFO - PROCESS | 1655 | Values: 66.0 66.0 66.0 61.0 64.0 64.0 66.0 64.0 66.0 67.0 07:19:45 INFO - PROCESS | 1655 | -------- Summary: end -------- 07:19:45 INFO - PROCESS | 1655 | 07:19:46 INFO - TEST-INFO | 1655: exit 0 07:19:46 INFO - TEST-OK | kraken | took 59902ms 07:19:46 INFO - SUITE-END | took 1173s 07:19:46 INFO - Completed test suite (00:19:34) 07:19:46 INFO - javascript benchmark 07:19:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7543.838754500033, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3081.2142903559597, 3550.733694972876, 3563.6436356364366, 3565.3582355176068, 3575.8927232183046, 5929.703514824258, 5966.4928481079105, 6004.579679422437, 6005.0, 6012.338642749294, 5985.221921150255, 6063.939360606392, 6079.057746049359, 6092.482139018178, 6116.571839971192, 4343.804528796196, 5384.7846086156505, 5392.110301800199, 5445.782168713246, 5451.560262098077, 4338.5932892047385, 5144.511271429208, 5450.482204190615, 5467.617266791306, 5473.480019398151, 5293.179557168645, 5297.8940421191555, 5426.810061647843, 5448.618596698233, 5463.262459567967, 5374.6237763356585, 5381.0852155133725, 5407.810726624549, 5415.323084614423, 5492.368377636543, 5308.177232528926, 5400.459954004607, 5406.945930540684, 5414.458554144593, 5443.537299329561, 5868.41315868414, 6001.759929602811, 6041.72812223451, 6124.601900876429, 6129.417705317987, 6203.844903877439, 6212.285587157489, 6228.937710622927, 6265.216847894013, 6309.936900630981, 5418.485243901823, 6376.936230637727, 6391.8402039948905, 6394.200724909387, 6415.518836087265, 6133.325334213233, 6143.631382117087, 6158.476529494998, 6165.260168779775, 6181.752729890754, 6189.947708889499, 6191.349908259568, 6384.233891932905, 6404.807855764335, 6409.903851442232, 6208.658523781145, 6286.18279623646, 6296.968515157395, 6297.1813664223355, 6306.621602703853, 6376.075469056961, 6376.7130479128555, 6379.617222966637, 6379.936200638027, 6386.9361306386345, 6190.473809726223, 6191.19514463117, 6199.256089269316, 6213.1922850029205, 6264.5301602380005, 6079.787207447806, 6243.157173781572, 6255.937440625627, 6257.186565746424, 6296.150019747275, 5171.3535808024, 5172.405173405032, 5172.7413629319135, 5175.508326709032, 5209.322788037607, 4489.5959363656775, 4519.661025423106, 4593.54064593538, 4633.930491042637, 4655.37152484417, 6163.753449862045, 6210.223722034746, 6212.4408803207925, 6249.312575616678, 6262.467690246289, 6346.428821406095, 6347.174867267226, 6359.0, 6380.298167201604, 6399.552031357854, 5923.259592550931, 6027.638341699512, 6104.26748790148, 6112.602680825732, 6123.387661233841, 5606.943930560642, 5615.736459296626, 5625.831225063254, 5629.915551266734, 5632.831015069554, 6492.350764923564, 6504.934950650528, 6519.4132528072705, 6529.5102867284195, 6535.411812936668, 6128.625347140727, 6198.783042593487, 6216.191895053614, 6282.780102696383, 6298.71655775482, 6587.110740050032, 6589.505787065893, 6604.108445360007, 6621.735130594722, 6624.635645039376, 6303.46420554258, 6315.273743519554, 6316.589421687576, 6320.08358787964, 6323.7786677466065, 5795.797147099831, 6221.09794079865, 6227.408396202353, 6310.905336420049, 6368.012957991518, 6152.230971128609, 6175.752969881154, 6231.906521402273, 6245.406686364788, 6278.434940855345, 5058.696478211319, 6194.876102478015, 6201.81394558164, 6232.688365581612, 6238.937610624017, 6066.545009124422, 6119.654885717031, 6131.621347939075, 6216.129741836237, 6247.625142491465, 6146.692665366624, 6151.50787936955, 6180.289266734203, 6236.625802451686, 6242.687865606611, 6195.0, 6221.191245138103, 6232.532560057924, 6234.781782637586, 6241.438270555672], "value": 5862.186464722757, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [454.7521600727603, 477.5224775224775, 494.41165013633776, 498.26754670634153, 560.683213984099, 33453.0, 37013.44479832801, 40976.0, 42376.788116059455, 42474.36288455676, 43895.0, 44502.77748611252, 44577.77711111448, 44656.55343446565, 44662.553374466246, 9003.459792412476, 9211.032841551641, 9528.475933823636, 9872.0, 9913.256505762061, 11946.104042196826, 12210.572629957953, 12219.327936963464, 12311.753764924697, 12349.0, 12149.331786751725, 12160.027197824153, 12168.51325946961, 12228.63314100574, 12238.632841014783, 12014.819777703255, 12029.458674359632, 12035.879641203563, 12051.758964820654, 12132.393380330948, 11931.0, 11996.880031199664, 12014.879851201464, 12062.336571488564, 12085.939570302093, 42791.35812962808, 42944.35583466251, 43033.92415189614, 43152.352714709305, 43264.78367608142, 4066.877993660195, 4117.670586353114, 4158.272302347107, 4209.7474151551005, 4246.193223287565, 30356.848215759, 30584.388312233852, 30629.08112756621, 30899.0, 32990.34019319624, 3273.6179914293352, 3308.503724441329, 3393.7115345195443, 3451.706604938583, 3495.3358861816428, 473845.0, 474264.0, 475029.0, 478939.0, 479264.0, 53574.0, 64701.67649161724, 64804.02793958, 64832.67583662052, 65107.02339464912, 68367.3163268361, 68457.65771171212, 68521.62956740937, 68545.65727171431, 68821.31178688249, 17646.117694115244, 17886.731699024524, 17893.7315940261, 17912.820871791115, 17933.0, 12527.373631318398, 12766.936165319114, 13668.453261869414, 13755.862441375459, 14077.436902523785, 18133.27466901309, 21388.893055534623, 22649.320520384415, 22679.86600669993, 22821.0, 7888.881666775003, 9350.532473376305, 9484.525773711286, 9545.713628591153, 9619.134277915022, 863.8963324401112, 872.7120050383485, 890.3811850763786, 908.9545522723837, 917.2799352508249, 30401.0, 30695.0, 31208.90768823126, 31355.90254341087, 31424.842875785474, 927.1146055516965, 1061.2942393308363, 1066.2802608239408, 1106.6403418888892, 1157.8494795676509, 12905.677358065936, 16267.0, 16308.429204978007, 16467.58831029234, 16626.83373166253, 694553.0, 701368.0, 701846.0, 702355.0, 703787.0, 63920.0, 64449.67775161188, 64481.03278450827, 64943.0, 65049.0, 1439.5609339151658, 1446.8914831387688, 1460.8100946876839, 1474.483930624273, 1479.6744716162427, 28785.0, 31176.688233118286, 31576.0, 31660.525092123175, 31666.208344791565, 51779.96440071102, 51838.0, 51864.481355187476, 52038.219426707874, 52103.73948130235, 598047.0, 602289.0, 602650.0, 603815.0, 605662.0, 25933.351666208495, 26977.920883164454, 27559.035433759724, 27636.894524218806, 45402.72986350603, 40598.59401406066, 44900.877478062, 45785.542144579464, 46525.767371162925, 46719.29921051119, 27886.442271154057, 27910.581341280304, 27997.160085197476, 28357.291067723472, 28880.411577363448, 30985.845070774503, 31006.53490197694, 31394.901178458644, 31551.684483154873, 31812.0, 30471.542926855673, 31425.057248281675, 37201.44197837089, 37264.0, 37293.25413491769, 25959.351016224744, 27682.584761229, 31363.84318078395, 31968.200794980312, 32226.516602250515, 23233.535329293656, 23790.762092379548, 24015.75984240205, 24744.628830567915, 24912.0], "value": 20820.901280525522, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.6572888620255, 404.38129661617734, 420.0884081543051, 422.2505053529984, 432.9630534868989, 19281.517962050955, 20005.0, 20634.6904796428, 20716.378508644746, 20934.371968840922, 22109.889450552764, 22278.331650050484, 22399.888000560015, 22447.887760561214, 23233.419164520896, 6097.634141951486, 6187.4431301182885, 6225.128482012522, 6236.03341482071, 6255.093011513328, 5991.340952495244, 6152.261728592553, 6211.627302361872, 6297.149884765567, 6318.336574659664, 6290.968545157268, 6320.083587879754, 6350.333215012426, 6361.173047503818, 6377.936220637804, 6428.100065990765, 7017.824554386156, 7023.262557431498, 7023.33278338557, 7030.507864449491, 6044.063170208625, 6182.876342473125, 6218.0, 6238.376162383771, 6278.340774218733, 13254.86745132546, 13319.467221311135, 14070.08544444618, 14215.578442155806, 26350.604740928902, 2624.39638883058, 2628.2772237634613, 2640.6435131257226, 2690.0584795321674, 2744.5745909384077, 7047.631406880942, 10497.475126243733, 10773.299735517245, 10905.781884362268, 11072.28030178044, 1941.2914286285404, 1943.9514012149668, 1944.6791279438876, 1949.6100779843946, 1977.4067779666043, 137493.3125334367, 138514.0, 146784.5321546792, 147157.0, 148736.2563187188, 9594.66418675343, 10306.793864122676, 12418.81371779424, 12458.252504849737, 12762.766515859688, 16584.17079146062, 16586.502404927873, 16592.917035414986, 16608.6678266434, 16665.91667041657, 8960.68637597681, 9322.720318390458, 9329.953350233205, 9364.672236471692, 9407.29445291606, 7895.131535531087, 8687.218150366498, 8928.553572321358, 9065.048169942193, 9185.816283674289, 5010.0, 5079.339685840817, 5082.745862706924, 5084.847454576368, 5088.185890257541, 1835.8434186462443, 2103.0431153824975, 2109.683547467892, 2147.8174355179985, 2157.7410710714817, 989.3569180033036, 1036.79782442423, 1039.0700323210835, 1042.760165162017, 1082.0856376361962, 20562.897185513975, 21047.789522104584, 21923.232686855885, 22033.118675253132, 22118.672879627273, 1036.6630844975414, 1045.5608644369383, 1050.2753100360726, 1077.5689724110262, 1089.455272363818, 11191.776164476665, 11414.029807466291, 11414.657560273039, 11426.200165988468, 11449.427528623535, 708337.0, 720791.0, 770291.0, 770833.1458342673, 794091.0, 143015.2849235747, 143017.28491357685, 143793.0, 146968.26515867352, 149065.2546737281, 1016.7813920007234, 1017.6997785653398, 1033.850091736694, 1060.9204309676804, 1066.0, 20165.899170504053, 20275.0, 21106.0, 21167.0, 21274.149034038466, 58380.708096459246, 60151.0, 60151.79696406135, 61355.0, 61518.0, 81217.59391203006, 86634.0, 87934.56032719795, 88246.0, 90043.0, 8279.544625045439, 8344.08215096351, 8481.15188481147, 8705.21653051203, 8894.866577001221, 9856.901430985597, 12799.168054076456, 12942.482300707867, 12963.092583519063, 13033.543825966046, 11086.279391839505, 11137.610183643534, 11262.436878155895, 11582.71043223926, 11598.652040438801, 7809.297163255334, 10142.594296228068, 10206.591736330463, 10578.259521833397, 10602.628907988492, 11378.772424551627, 11647.941760291144, 11658.94170529142, 11853.644390668294, 11872.821907671565, 7506.474546781673, 7721.92278077212, 8459.534725590152, 8495.915040849512, 8542.231199191854, 11382.658520244406, 11389.088872889983, 11449.370284634426, 11524.654260372203, 11776.0], "value": 10143.514615141412, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1467.4643755029417, 1489.8808095352372, 1499.3927459378951, 1504.1877386211447, 1509.6829665770188, 7749.4962827416175, 8018.9198108019045, 8260.752177434671, 8670.913290867089, 8682.479051256922, 6513.576617519858, 8625.827483450343, 8626.698065567707, 8632.913670863305, 8671.479711217331, 2175.8476906616543, 2382.65451509531, 2440.3045132137345, 2441.145599040339, 2444.767747064035, 2422.079609748302, 2448.926532204028, 2452.8896199670967, 2455.668484754562, 2464.37158524576, 2405.9518809623796, 2412.203972689017, 2432.72023717273, 2436.5735996200683, 2444.4133407982135, 2173.5978843913927, 2402.6756387887585, 2408.3617841272076, 2427.635854621812, 2431.3313838694326, 2250.504888924434, 2432.4283793308737, 2440.7803297703113, 2445.8165637577254, 2446.7186273578586, 8567.914320856775, 8594.87107693385, 8656.047834738174, 8678.956605216996, 8741.912580874174, 4458.5318541553315, 4766.404199475066, 5144.331236939174, 5397.190421436777, 5405.432429594875, 3435.485075555782, 3445.879394221215, 3507.3862074136923, 3550.3609350316933, 3589.2283159120916, 1215.5867005218267, 1238.5231685801032, 1265.5886836778084, 1299.8375203099613, 1305.8237137986441, 10999.065079468255, 11095.944520277348, 11101.222914395996, 11107.222494425312, 11116.221864469491, 4029.3955906613655, 4590.1737687215955, 4763.904721905612, 4788.832390866303, 4848.200046992278, 9690.46702431373, 9709.854352184722, 9713.611455541699, 9729.805403892024, 9744.317897747089, 5414.7021913795115, 5428.212909128154, 5435.0, 5442.482964118402, 5443.863903402446, 4252.383404406344, 4454.910901781946, 4514.796834142471, 4923.187674033816, 4970.950290497049, 3410.9317813644084, 3990.3216453203027, 4038.3134867072667, 4105.384192371168, 4119.814608342632, 1131.4851742457163, 1331.966700832487, 1339.450825161679, 1352.5874608244383, 1355.3697530648296, 944.471096186138, 961.2550273538064, 963.6723514005272, 975.2636759246865, 1015.3704703084135, 4718.693284936468, 5579.776808927598, 5826.2134611827705, 6001.1898393717165, 6010.9699451502465, 603.8399824046631, 606.7936901453438, 607.9300880398722, 611.4466407900857, 612.761023200952, 3197.7921435106646, 3490.3193877194212, 3814.809259537012, 3908.022994251437, 3957.3074711925874, 9781.217502599775, 9793.314467987315, 10240.64157754475, 10247.692569222936, 10335.793284134275, 10224.64213752515, 10324.019218174262, 10359.63741269052, 10384.688459346231, 10386.013328733758, 8003.319717823933, 8134.0, 8202.138775428613, 8215.712450064219, 8266.710665126691, 5906.645601263938, 5910.527157827278, 5945.702714864153, 6070.028795392893, 6121.540884433774, 7895.68417263303, 9488.810223795623, 9517.238620910171, 9579.185769209416, 9686.128248457673, 9137.451752894847, 9451.338406311492, 9510.904890951279, 9628.277879158952, 9657.034296570288, 6800.217974932748, 7011.053507776385, 7151.785446436407, 7313.634318284171, 7472.701091956261, 7919.2872641462545, 8174.754757357289, 8213.342932565261, 8218.835623287381, 8226.958865205635, 7091.290870912868, 7226.4218862491925, 7254.818629534304, 7287.963560182166, 7352.154502232098, 7228.602426866572, 7351.522151060164, 7366.189719130784, 7372.7050917964825, 7518.173000969999, 6346.841328966812, 6479.222493300834, 6493.545451818516, 6503.869922601427, 6505.121808555785, 5078.746062696924, 5114.641975061859, 5154.7938082476285, 5259.60552958522, 5330.440303768049, 5106.839943920109, 5177.0, 5274.050670879278, 5406.810761623325, 5408.512659018801], "value": 4490.028917925003, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.82133737113276, 383.97312188146833, 385.56431232707035, 391.9764814111152, 395.76254247451516, 4851.1025460289875, 5429.425466614682, 5536.228406909785, 5552.5280351170095, 5593.244911936892, 4539.909201815962, 4731.952680473194, 4885.364902562671, 5092.261622064799, 5331.294750148648, 4229.885057471264, 4292.574695297163, 4308.97845510772, 4317.301686445971, 4351.934720979172, 4155.958440415602, 4337.674674399417, 4343.2182207202695, 4348.456442944632, 4379.948812285061, 4112.527059388164, 4309.461317335333, 4315.244832154361, 4328.761918094504, 4346.282863327548, 3676.283124790667, 4068.7825135301036, 4175.394567787669, 4264.424302719124, 4269.359596060584, 3510.80690562019, 3634.3821550336506, 3796.8481260749536, 3809.2000679857265, 3817.3510503214243, 5354.170103633943, 5355.3305836770405, 5365.765873848997, 5389.73051347435, 5397.001554712351, 4275.337322714984, 4808.994378513429, 4965.379327584052, 5031.396232452093, 5032.370953630796, 4915.631327650441, 5600.943990560083, 5858.455634341248, 5885.176075349455, 5891.911621325684, 3742.3825068863875, 3811.5045044144363, 4253.659707223445, 4267.701260911737, 4281.293586558214, 5208.817691380784, 5669.23465332179, 6167.87664246717, 6186.350433204494, 6214.782482613087, 4310.202612516632, 4311.913761724748, 4326.394304797331, 4339.500957389941, 4355.128974205171, 3738.9626103738615, 4405.140997505519, 4405.889852753707, 4422.513523512411, 4444.044530425909, 4236.533981262059, 4924.863114983431, 4981.302617633534, 5037.345145131183, 5056.9494305057215, 5864.914990726729, 5882.264746892715, 5889.5582831286965, 5894.67579283135, 5941.792037278761, 1277.7222777222778, 1293.5964478540889, 1416.362636813438, 1455.9126452412677, 1468.9853101469062, 778.1051790440926, 889.0886840988039, 907.7004588485784, 1015.4161357219481, 1017.5624481473037, 4961.975190124026, 5126.871828204325, 5326.573874090063, 5341.172118321666, 5364.892702145935, 5064.392272927199, 5387.299651045339, 5559.610097475631, 5711.343195532484, 5802.79690210849, 4611.708721557902, 4692.601128904082, 4748.1956856394345, 5093.312402825645, 5313.867153321198, 2634.4335967767024, 2653.7346265373308, 2668.679758429001, 3068.861901214451, 3070.401271752032, 6066.483379155211, 6068.180795592627, 6072.51419886408, 6074.268833382464, 6089.112375163713, 5640.943590564042, 5853.560982926298, 5927.5993222744855, 5952.898713737973, 5971.0, 4924.3654644764165, 5311.6986338345805, 5700.857478563069, 6128.785492507741, 6128.969355153285, 5752.338481074563, 6061.878762424815, 6101.176341193882, 6117.877642447037, 6120.163950814649, 5459.481349271813, 5658.943410565842, 5931.3178984417345, 5987.371326010881, 5993.910091348546, 5584.497395234448, 6168.568200226121, 6222.719977600928, 6257.99360511598, 6312.526560508072, 3310.5365248864696, 3683.0424089736325, 3701.8704345347783, 4047.959520404876, 4057.2494088593703, 5246.921296180637, 5707.286589176353, 5788.989725342714, 6016.8784382697995, 6043.093535969464, 5183.974080129575, 5228.71242081674, 5412.512873841373, 5871.975932394735, 5894.616849904743, 4663.603593694438, 5650.704590947786, 5740.827775166752, 5868.501177399798, 5891.852703682443, 4886.462489126265, 5780.7398667060925, 5807.651540907559, 5835.2122463466885, 5840.065589505659, 5932.673702946379, 5941.940580594139, 5964.850878728066, 5998.890205312031, 6011.338752737108, 5137.794488220429, 5415.296011518635, 5701.971490142523, 5738.799142030009, 5813.4013146383395], "value": 4293.7285453280165, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [718.5724493926116, 726.7165805335917, 772.6021099133947, 840.0465471689632, 843.4348986179261, 17618.383356582523, 18370.081495925217, 18407.07964601771, 18434.907825460872, 18488.35290764822, 16624.919380240277, 17637.206325715342, 17761.20074596643, 17874.28502859887, 17958.0, 718.5652680128526, 875.2778957360172, 891.7235656946367, 895.0512456795785, 911.8404279251138, 908.7546362482126, 909.9772505687345, 910.9498977556232, 913.5158366065996, 913.6208473483497, 946.4463288975958, 954.4321128928276, 955.0, 955.2119501411329, 957.2533423929311, 939.1172298039821, 951.1392190068, 954.3271993244781, 954.5275088831038, 955.6034245787989, 694.3265032918061, 696.8919817428307, 697.3793323941696, 709.6806437103324, 710.3251910684818, 15969.520914372471, 15982.76025859613, 16351.672966540722, 16602.0, 16966.40617578391, 14469.78295325571, 14507.347169377403, 14599.0, 14650.780238296327, 14710.852891471162, 11804.881951180465, 12002.0, 12014.159008869383, 12080.818787718192, 12630.368481575884, 3893.7274390792654, 3906.433567132778, 4000.959990400117, 4028.174224284044, 4037.9394309085387, 115098.0, 115350.0, 116680.0, 117089.41455292754, 119040.0, 11142.721431964104, 11228.831567526493, 11283.605073822377, 11336.773264534662, 12126.636200913987, 22119.225827095976, 22869.97085131173, 23207.0, 23431.7656823433, 23442.413939651644, 7864.606769661608, 8214.63034163464, 8274.29668478174, 8286.047104582929, 8375.623096960651, 4406.383106365111, 4411.536788637211, 4467.597916187558, 4506.977465112719, 4513.210188217115, 3746.625337466286, 3793.3551296279697, 3841.9231615368094, 3845.615438456188, 3855.2289542091694, 700.6881937537848, 710.6411262312499, 718.3750137380408, 718.9898193038789, 719.650655021834, 688.2944981394111, 691.3294104718415, 712.4529805943772, 728.5483000539593, 744.1776836595592, 9629.422234665943, 10569.67879015123, 10575.524101415454, 10594.739321218702, 10905.890941090645, 697.5570512724355, 716.451914285572, 732.9120505539263, 734.5262305812828, 734.5482528245091, 4809.470958194595, 5122.615803814729, 5141.794328226829, 5152.330197074356, 5152.690838549699, 105517.94482055235, 107926.3811042835, 110061.44969275102, 114025.0, 115695.42152289185, 91790.0, 96113.51943240239, 98230.0, 99952.0, 100393.0, 78610.60694696604, 79096.81354779568, 80376.0, 81835.0, 81835.5908220455, 9688.9031109688, 9818.410895346302, 9890.406575605199, 9952.950235248778, 9953.950230248802, 55688.16467753068, 56129.71935140298, 56349.43650563606, 56762.432375675715, 57112.71443642755, 71151.9327210082, 72331.27668723246, 73748.0, 73824.0, 76793.2320676786, 11740.471678774305, 11783.410829458664, 11851.881481185077, 12143.0, 12451.501939922664, 12888.871111288767, 13126.409311581192, 13134.60596182116, 13365.53220637273, 13403.994700397314, 12013.939930300292, 12086.456109474919, 12256.448459819152, 12531.934785542966, 12751.489940402651, 12042.397880105784, 12430.627081187216, 12640.6839829005, 12681.556145534862, 12716.491340346283, 11708.0, 12115.15193936416, 12120.818187727367, 12122.939385303018, 12184.476940382452, 7133.643317833984, 7378.372838308804, 7536.4615575089765, 7662.080550333995, 7724.459287849797, 8966.86549701742, 9080.40977336471, 9966.352187107816, 10003.2997690161, 10032.749181270527], "value": 7721.054173955124, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1502.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 118.0, 119.0, 115.0, 114.0, 99.0, 163.0, 173.0, 99.0, 157.0], "value": 126.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 139.0, 143.0, 146.0, 110.0, 109.0, 102.0, 139.0, 158.0, 111.0], "value": 133.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 195.0, 195.0, 197.0, 198.0, 197.0, 232.0, 196.0, 193.0, 197.0], "value": 199.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 74.0, 81.0, 83.0, 56.0, 73.0, 52.0, 49.0, 63.0, 50.0], "value": 65.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 68.0, 81.0, 70.0, 69.0, 70.0, 81.0, 69.0, 71.0, 85.0], "value": 75.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 110.0, 84.0, 127.0, 99.0, 92.0, 122.0, 89.0, 114.0], "value": 101.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 122.0, 96.0, 98.0, 113.0, 98.0, 98.0, 105.0, 97.0, 99.0], "value": 103.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 126.0, 98.0, 92.0, 91.0, 93.0, 91.0, 90.0, 93.0, 92.0], "value": 100.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 60.0, 58.0, 62.0, 63.0, 64.0, 63.0, 64.0, 62.0, 62.0], "value": 61.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 80.0, 77.0, 71.0, 69.0, 69.0, 69.0, 70.0, 70.0], "value": 70.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 86.0, 82.0, 80.0, 84.0, 82.0, 89.0, 88.0, 88.0], "value": 84.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 135.0, 136.0, 145.0, 154.0, 149.0, 147.0, 154.0, 184.0, 137.0], "value": 147.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 165.0, 166.0, 165.0, 166.0, 164.0, 170.0, 164.0, 179.0], "value": 166.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 61.0, 64.0, 64.0, 66.0, 64.0, 66.0, 67.0], "value": 65.0, "unit": "score"}]}]} 07:19:46 INFO - Return code: 0 07:19:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:19:46 ERROR - # TBPL SUCCESS # 07:19:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:19:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:19:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:19:46 INFO - 2017-04-10 07:19:46.846 screenresolution[1660:10415] starting screenresolution argv=screenresolution get 07:19:46 INFO - 2017-04-10 07:19:46.848 screenresolution[1660:10415] Display 0: 1600x1200x32@60 07:19:46 INFO - 2017-04-10 07:19:46.854 screenresolution[1661:10419] starting screenresolution argv=screenresolution list 07:19:46 INFO - Available Modes on Display 0 07:19:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:19:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:19:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:19:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:19:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:19:47 INFO - Intel Iris: 07:19:47 INFO - Chipset Model: Intel Iris 07:19:47 INFO - Type: GPU 07:19:47 INFO - Bus: Built-In 07:19:47 INFO - VRAM (Dynamic, Max): 1536 MB 07:19:47 INFO - Vendor: Intel (0x8086) 07:19:47 INFO - Device ID: 0x0a2e 07:19:47 INFO - Revision ID: 0x0009 07:19:47 INFO - Displays: 07:19:47 INFO - Display: 07:19:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:19:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:19:47 INFO - Display Serial Number: 1600x1200 60 07:19:47 INFO - Main Display: Yes 07:19:47 INFO - Mirror: Off 07:19:47 INFO - Online: Yes 07:19:47 INFO - Rotation: Supported 07:19:47 INFO - Return code: 0 07:19:47 INFO - Running post-action listener: _resource_record_post_action 07:19:47 INFO - [mozharness: 2017-04-10 14:19:47.098846Z] Finished run-tests step (success) 07:19:47 INFO - Running post-run listener: _resource_record_post_run 07:19:47 INFO - Total resource usage - Wall time: 1189s; CPU: 54.0%; Read bytes: 41162752; Write bytes: 424717824; Read time: 396; Write time: 1380 07:19:47 INFO - TinderboxPrint: CPU usage
54.5% 07:19:47 INFO - TinderboxPrint: I/O read bytes / time
41,162,752 / 396 07:19:47 INFO - TinderboxPrint: I/O write bytes / time
424,717,824 / 1,380 07:19:47 INFO - TinderboxPrint: CPU idle
2,165.2 (45.5%) 07:19:47 INFO - TinderboxPrint: CPU system
960.6 (20.2%) 07:19:47 INFO - TinderboxPrint: CPU user
1,632.0 (34.3%) 07:19:47 INFO - TinderboxPrint: Swap in / out
163,176,448 / 0 07:19:47 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 113633792; Write bytes: 112771072; Read time: 10067; Write time: 219 07:19:47 INFO - run-tests - Wall time: 1175s; CPU: 55.0%; Read bytes: 40208384; Write bytes: 300849152; Read time: 381; Write time: 1106 07:19:47 INFO - Running post-run listener: _upload_blobber_files 07:19:47 INFO - Blob upload gear active. 07:19:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:19:47 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 07:19:47 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:19:47 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:19:47 INFO - (blobuploader) - INFO - Open directory for files ... 07:19:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:19:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:19:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:19:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:19:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:19:49 INFO - (blobuploader) - INFO - Done attempting. 07:19:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:19:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:19:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:19:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:19:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:19:49 INFO - (blobuploader) - INFO - Done attempting. 07:19:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:19:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:19:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:19:50 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:19:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:19:50 INFO - (blobuploader) - INFO - Done attempting. 07:19:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:19:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:19:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:19:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:19:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:19:52 INFO - (blobuploader) - INFO - Done attempting. 07:19:52 INFO - (blobuploader) - INFO - Iteration through files over. 07:19:52 INFO - Return code: 0 07:19:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:19:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:19:52 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/def56c564e862f617d36d9364e2f9dd7d6ac1d7b73347de78d5418d794b4d54a5a7ed30863f9babed45ecc0b450aa8489e6c7684c814aa684d823b348c6369cc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6d291e68194ac0f74210e7aa7ab8340aa9eaf781ad79b5656d42e950e65f8bc33425999927eb5f52829988b2bc7675fb97dde1c450d3d4d95b7822ac47bc25d6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e34c600b18ce0d7a890159dd875e20aeff40c9cb1fd305b262ce77bc79ae62887f0ff73ac9f39624d0299d3c9618510b35466339cb5e1bbc02eec0c5faa0762c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4e152c907e6b45d7a8653b5e41af5806d6b122c80a3fd1430540faff069c9227bdf222c820c15fa64d79a7195dfb323c5d0c1fb63f689d0e18bdc719fe06f73f"} 07:19:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:19:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:19:52 INFO - Contents: 07:19:52 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/def56c564e862f617d36d9364e2f9dd7d6ac1d7b73347de78d5418d794b4d54a5a7ed30863f9babed45ecc0b450aa8489e6c7684c814aa684d823b348c6369cc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6d291e68194ac0f74210e7aa7ab8340aa9eaf781ad79b5656d42e950e65f8bc33425999927eb5f52829988b2bc7675fb97dde1c450d3d4d95b7822ac47bc25d6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e34c600b18ce0d7a890159dd875e20aeff40c9cb1fd305b262ce77bc79ae62887f0ff73ac9f39624d0299d3c9618510b35466339cb5e1bbc02eec0c5faa0762c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4e152c907e6b45d7a8653b5e41af5806d6b122c80a3fd1430540faff069c9227bdf222c820c15fa64d79a7195dfb323c5d0c1fb63f689d0e18bdc719fe06f73f"} 07:19:52 INFO - Running post-run listener: copy_logs_to_upload_dir 07:19:52 INFO - Copying logs to upload dir... 07:19:52 INFO - mkdir: /builds/slave/test/build/upload/logs 07:19:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.840887 ========= master_lag: 0.26 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-04-10 07:19:53.180357) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-10 07:19:53.184092) ========= 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.7ItqocMtKR/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.T1wJJreoFW/Listeners TMPDIR=/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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/Mozilla-Beta/sha512/def56c564e862f617d36d9364e2f9dd7d6ac1d7b73347de78d5418d794b4d54a5a7ed30863f9babed45ecc0b450aa8489e6c7684c814aa684d823b348c6369cc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6d291e68194ac0f74210e7aa7ab8340aa9eaf781ad79b5656d42e950e65f8bc33425999927eb5f52829988b2bc7675fb97dde1c450d3d4d95b7822ac47bc25d6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e34c600b18ce0d7a890159dd875e20aeff40c9cb1fd305b262ce77bc79ae62887f0ff73ac9f39624d0299d3c9618510b35466339cb5e1bbc02eec0c5faa0762c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4e152c907e6b45d7a8653b5e41af5806d6b122c80a3fd1430540faff069c9227bdf222c820c15fa64d79a7195dfb323c5d0c1fb63f689d0e18bdc719fe06f73f"} build_url:https://queue.taskcluster.net/v1/task/eHNgSB_US1eINl4ocrUeiQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011471 build_url: 'https://queue.taskcluster.net/v1/task/eHNgSB_US1eINl4ocrUeiQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/def56c564e862f617d36d9364e2f9dd7d6ac1d7b73347de78d5418d794b4d54a5a7ed30863f9babed45ecc0b450aa8489e6c7684c814aa684d823b348c6369cc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6d291e68194ac0f74210e7aa7ab8340aa9eaf781ad79b5656d42e950e65f8bc33425999927eb5f52829988b2bc7675fb97dde1c450d3d4d95b7822ac47bc25d6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e34c600b18ce0d7a890159dd875e20aeff40c9cb1fd305b262ce77bc79ae62887f0ff73ac9f39624d0299d3c9618510b35466339cb5e1bbc02eec0c5faa0762c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4e152c907e6b45d7a8653b5e41af5806d6b122c80a3fd1430540faff069c9227bdf222c820c15fa64d79a7195dfb323c5d0c1fb63f689d0e18bdc719fe06f73f"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-10 07:19:53.220688) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 07:19:53.221494) ========= 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.7ItqocMtKR/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.T1wJJreoFW/Listeners TMPDIR=/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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.005368 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 07:19:53.271317) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-10 07:19:53.271651) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-10 07:19:53.271991) ========= ========= Total master_lag: 0.40 =========