builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0374 starttime: 1487932332.99 results: success (0) buildid: 20170224004003 builduid: 72d918d20ddc40f6969873f691a93f46 revision: 883dd404cfa2bab84de402e87484e1b2b268f466 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-24 02:32:12.986458) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-24 02:32:12.986912) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-24 02:32:12.987266) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-24 02:32:13.011459) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-24 02:32:13.011777) ========= 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.ezIfkbM4cX/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.iyXwnWOk3i/Listeners TMPDIR=/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/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-02-24 02:32:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 164M=0s 2017-02-24 02:32:13 (164 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.184170 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-24 02:32:13.218727) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-24 02:32:13.219067) ========= 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.ezIfkbM4cX/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.iyXwnWOk3i/Listeners TMPDIR=/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/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.021388 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-24 02:32:13.267846) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-24 02:32:13.268206) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 883dd404cfa2bab84de402e87484e1b2b268f466 --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-aurora --rev 883dd404cfa2bab84de402e87484e1b2b268f466 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ezIfkbM4cX/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.iyXwnWOk3i/Listeners TMPDIR=/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/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-02-24 02:32:13,362 truncating revision to first 12 chars 2017-02-24 02:32:13,363 Setting DEBUG logging. 2017-02-24 02:32:13,363 attempt 1/10 2017-02-24 02:32:13,363 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/883dd404cfa2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-24 02:32:14,359 unpacking tar archive at: mozilla-aurora-883dd404cfa2/testing/mozharness/ program finished with exit code 0 elapsedTime=1.258350 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-24 02:32:14.549819) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-24 02:32:14.550155) ========= script_repo_revision: 883dd404cfa2bab84de402e87484e1b2b268f466 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-24 02:32:14.550585) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-24 02:32:14.550861) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-24 02:32:14.570101) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-02-24 02:32:14.570504) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ezIfkbM4cX/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.iyXwnWOk3i/Listeners TMPDIR=/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/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 02:32:14 INFO - MultiFileLogger online at 20170224 02:32:14 in /builds/slave/test 02:32:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:32:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:32:14 INFO - {'append_to_log': False, 02:32:14 INFO - 'base_work_dir': '/builds/slave/test', 02:32:14 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:32:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:32:14 INFO - 'branch': 'Mozilla-Aurora', 02:32:14 INFO - 'buildbot_json_path': 'buildprops.json', 02:32:14 INFO - 'config_files': ('talos/mac_config.py',), 02:32:14 INFO - 'default_actions': ('clobber', 02:32:14 INFO - 'read-buildbot-config', 02:32:14 INFO - 'download-and-extract', 02:32:14 INFO - 'populate-webroot', 02:32:14 INFO - 'create-virtualenv', 02:32:14 INFO - 'install', 02:32:14 INFO - 'run-tests'), 02:32:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:32:14 INFO - 'download_minidump_stackwalk': True, 02:32:14 INFO - 'download_symbols': 'ondemand', 02:32:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:32:14 INFO - 'tooltool.py': '/tools/tooltool.py', 02:32:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:32:14 INFO - '/tools/misc-python/virtualenv.py')}, 02:32:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:32:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:32:14 INFO - 'installer_path': 'installer.exe', 02:32:14 INFO - 'log_level': 'info', 02:32:14 INFO - 'log_name': 'talos', 02:32:14 INFO - 'log_to_console': True, 02:32:14 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:32:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:32:14 INFO - 'opt_config_files': (), 02:32:14 INFO - 'pip_index': False, 02:32:14 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:32:14 INFO - 'cmd': ('bash', 02:32:14 INFO - '-c', 02:32:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:32:14 INFO - 'enabled': True, 02:32:14 INFO - 'halt_on_failure': False, 02:32:14 INFO - 'name': 'check_screen_resolution'},), 02:32:14 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:32:14 INFO - 'cmd': ('bash', 02:32:14 INFO - '-c', 02:32:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:32:14 INFO - 'enabled': True, 02:32:14 INFO - 'halt_on_failure': False, 02:32:14 INFO - 'name': 'check_screen_resolution'},), 02:32:14 INFO - 'run_cmd_checks_enabled': True, 02:32:14 INFO - 'sps_profile': False, 02:32:14 INFO - 'sps_profile_interval': 0, 02:32:14 INFO - 'suite': 'dromaeojs-e10s', 02:32:14 INFO - 'system_bits': '32', 02:32:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:32:14 INFO - 'title': 't-yosemite-r7-0374', 02:32:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:32:14 INFO - 'use_talos_json': True, 02:32:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:32:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:32:14 INFO - 'work_dir': 'build'} 02:32:14 INFO - [mozharness: 2017-02-24 10:32:14.785257Z] Running clobber step. 02:32:14 INFO - Running pre-action listener: _resource_record_pre_action 02:32:14 INFO - Running main action method: clobber 02:32:14 INFO - rmtree: /builds/slave/test/build 02:32:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:32:16 INFO - Running post-action listener: _resource_record_post_action 02:32:16 INFO - [mozharness: 2017-02-24 10:32:16.468920Z] Finished clobber step (success) 02:32:16 INFO - [mozharness: 2017-02-24 10:32:16.469055Z] Running read-buildbot-config step. 02:32:16 INFO - Running pre-action listener: _resource_record_pre_action 02:32:16 INFO - Running main action method: read_buildbot_config 02:32:16 INFO - Using buildbot properties: 02:32:16 INFO - { 02:32:16 INFO - "project": "", 02:32:16 INFO - "product": "firefox", 02:32:16 INFO - "script_repo_revision": "production", 02:32:16 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 02:32:16 INFO - "repository": "", 02:32:16 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 02:32:16 INFO - "buildid": "20170224004003", 02:32:16 INFO - "stage_platform": "macosx64", 02:32:16 INFO - "basedir": "/builds/slave/test", 02:32:16 INFO - "nightly_build": "True", 02:32:16 INFO - "buildnumber": 54, 02:32:16 INFO - "slavename": "t-yosemite-r7-0374", 02:32:16 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 02:32:16 INFO - "platform": "yosemite_r7", 02:32:16 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:32:16 INFO - "branch": "mozilla-aurora", 02:32:16 INFO - "repo_path": "releases/mozilla-aurora", 02:32:16 INFO - "revision": "883dd404cfa2bab84de402e87484e1b2b268f466", 02:32:16 INFO - "pgo_build": "False", 02:32:16 INFO - "builduid": "72d918d20ddc40f6969873f691a93f46", 02:32:16 INFO - "slavebuilddir": "test" 02:32:16 INFO - } 02:32:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/CS6MS_A5TtS3pYoG46LpVg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 02:32:16 INFO - Running post-action listener: _resource_record_post_action 02:32:16 INFO - [mozharness: 2017-02-24 10:32:16.472637Z] Finished read-buildbot-config step (success) 02:32:16 INFO - [mozharness: 2017-02-24 10:32:16.472770Z] Running download-and-extract step. 02:32:16 INFO - Running pre-action listener: _resource_record_pre_action 02:32:16 INFO - Running main action method: download_and_extract 02:32:16 INFO - mkdir: /builds/slave/test/build/tests 02:32:16 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')]} 02:32:16 INFO - trying https://queue.taskcluster.net/v1/task/CS6MS_A5TtS3pYoG46LpVg/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 02:32:16 INFO - Downloading https://queue.taskcluster.net/v1/task/CS6MS_A5TtS3pYoG46LpVg/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 02:32:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CS6MS_A5TtS3pYoG46LpVg/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 02:32:17 INFO - Downloaded 1199 bytes. 02:32:17 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 02:32:17 INFO - Using the following test package requirements: 02:32:17 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 02:32:17 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:32:17 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 02:32:17 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:32:17 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 02:32:17 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:32:17 INFO - u'jsshell-mac.zip'], 02:32:17 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:32:17 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 02:32:17 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 02:32:17 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:32:17 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 02:32:17 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:32:17 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 02:32:17 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:32:17 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 02:32:17 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:32:17 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 02:32:17 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:32:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CS6MS_A5TtS3pYoG46LpVg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 02:32:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CS6MS_A5TtS3pYoG46LpVg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:32:17 INFO - Fetch https://queue.taskcluster.net/v1/task/CS6MS_A5TtS3pYoG46LpVg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 02:32:18 INFO - Expected file size: 16357901 02:32:18 INFO - Obtained file size: 16357901 02:32:24 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 02:32:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CS6MS_A5TtS3pYoG46LpVg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 02:32:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CS6MS_A5TtS3pYoG46LpVg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:32:24 INFO - Fetch https://queue.taskcluster.net/v1/task/CS6MS_A5TtS3pYoG46LpVg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 02:32:25 INFO - Expected file size: 16357901 02:32:25 INFO - Obtained file size: 16357901 02:32:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CS6MS_A5TtS3pYoG46LpVg/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 02:32:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CS6MS_A5TtS3pYoG46LpVg/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:32:32 INFO - Fetch https://queue.taskcluster.net/v1/task/CS6MS_A5TtS3pYoG46LpVg/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 02:32:32 INFO - Expected file size: 14403472 02:32:32 INFO - Obtained file size: 14403472 02:32:33 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')]} 02:32:33 INFO - trying https://queue.taskcluster.net/v1/task/CS6MS_A5TtS3pYoG46LpVg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 02:32:33 INFO - Downloading https://queue.taskcluster.net/v1/task/CS6MS_A5TtS3pYoG46LpVg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 02:32:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CS6MS_A5TtS3pYoG46LpVg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 02:32:35 INFO - Downloaded 74042037 bytes. 02:32:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CS6MS_A5TtS3pYoG46LpVg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 02:32:35 INFO - mkdir: /builds/slave/test/properties 02:32:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:32:35 INFO - Writing to file /builds/slave/test/properties/build_url 02:32:35 INFO - Contents: 02:32:35 INFO - build_url:https://queue.taskcluster.net/v1/task/CS6MS_A5TtS3pYoG46LpVg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 02:32:35 INFO - Running post-action listener: _resource_record_post_action 02:32:35 INFO - Running post-action listener: set_extra_try_arguments 02:32:35 INFO - [mozharness: 2017-02-24 10:32:35.992945Z] Finished download-and-extract step (success) 02:32:35 INFO - [mozharness: 2017-02-24 10:32:35.993088Z] Running populate-webroot step. 02:32:35 INFO - Running pre-action listener: _resource_record_pre_action 02:32:35 INFO - Running main action method: populate_webroot 02:32:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:32:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:32:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:32:36 INFO - '--tppagecycles', 02:32:36 INFO - '7'], 02:32:36 INFO - 'tests': ['tsvgm']}}, 02:32:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:32:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:32:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:32:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:32:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:32:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:32:36 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:32:36 INFO - 'talos_options': ['--disable-e10s'], 02:32:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:32:36 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:32:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:32:36 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:32:36 INFO - 'talos_options': ['--disable-e10s'], 02:32:36 INFO - 'tests': ['damp', 'tps']}, 02:32:36 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:32:36 INFO - 'tests': ['damp', 'tps']}, 02:32:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:32:36 INFO - 'tests': ['dromaeo_dom']}, 02:32:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:32:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:32:36 INFO - 'tests': ['basic_compositor_video']}, 02:32:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:32:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:32:36 INFO - 'tests': ['a11yr', 02:32:36 INFO - 'ts_paint', 02:32:36 INFO - 'tpaint', 02:32:36 INFO - 'sessionrestore', 02:32:36 INFO - 'sessionrestore_no_auto_restore', 02:32:36 INFO - 'tabpaint']}, 02:32:36 INFO - 'other-e10s': {'tests': ['a11yr', 02:32:36 INFO - 'ts_paint', 02:32:36 INFO - 'tpaint', 02:32:36 INFO - 'sessionrestore', 02:32:36 INFO - 'sessionrestore_no_auto_restore', 02:32:36 INFO - 'tabpaint']}, 02:32:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:32:36 INFO - 'ts_paint', 02:32:36 INFO - 'tpaint', 02:32:36 INFO - 'sessionrestore', 02:32:36 INFO - 'sessionrestore_no_auto_restore', 02:32:36 INFO - 'tabpaint']}, 02:32:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:32:36 INFO - 'ts_paint', 02:32:36 INFO - 'tpaint', 02:32:36 INFO - 'sessionrestore', 02:32:36 INFO - 'sessionrestore_no_auto_restore', 02:32:36 INFO - 'tabpaint']}, 02:32:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:32:36 INFO - 'tests': ['a11yr', 02:32:36 INFO - 'ts_paint', 02:32:36 INFO - 'tpaint', 02:32:36 INFO - 'sessionrestore', 02:32:36 INFO - 'sessionrestore_no_auto_restore', 02:32:36 INFO - 'tabpaint']}, 02:32:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:32:36 INFO - 'tests': ['a11yr', 02:32:36 INFO - 'ts_paint', 02:32:36 INFO - 'tpaint', 02:32:36 INFO - 'sessionrestore', 02:32:36 INFO - 'sessionrestore_no_auto_restore', 02:32:36 INFO - 'tabpaint']}, 02:32:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:32:36 INFO - 'tests': ['tsvgx', 02:32:36 INFO - 'tsvgr_opacity', 02:32:36 INFO - 'tart', 02:32:36 INFO - 'tscrollx', 02:32:36 INFO - 'cart', 02:32:36 INFO - 'tsvg_static']}, 02:32:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:32:36 INFO - 'tsvgr_opacity', 02:32:36 INFO - 'tart', 02:32:36 INFO - 'tscrollx', 02:32:36 INFO - 'cart', 02:32:36 INFO - 'tsvg_static']}, 02:32:36 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:32:36 INFO - 'talos_options': ['--disable-e10s'], 02:32:36 INFO - 'tests': ['tp5o']}, 02:32:36 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:32:36 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:32:36 INFO - 'talos_options': ['--disable-e10s', 02:32:36 INFO - '--xperf_path', 02:32:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:32:36 INFO - 'tests': ['tp5n']}, 02:32:36 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:32:36 INFO - 'talos_options': ['--xperf_path', 02:32:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:32:36 INFO - 'tests': ['tp5n']}}, 02:32:36 INFO - 'talos.zip': {'path': '', 02:32:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:32:36 INFO - Running post-action listener: _resource_record_post_action 02:32:36 INFO - [mozharness: 2017-02-24 10:32:36.011436Z] Finished populate-webroot step (success) 02:32:36 INFO - [mozharness: 2017-02-24 10:32:36.011576Z] Running create-virtualenv step. 02:32:36 INFO - Running pre-action listener: _resource_record_pre_action 02:32:36 INFO - Running main action method: create_virtualenv 02:32:36 INFO - Creating virtualenv /builds/slave/test/build/venv 02:32:36 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 02:32:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:32:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:32:36 INFO - Using real prefix '/tools/python27' 02:32:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:32:36 INFO - Installing distribute.............................................................................................................................................................................................done. 02:32:39 INFO - Installing pip.................done. 02:32:39 INFO - Return code: 0 02:32:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:32:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:32:39 INFO - Reading from file tmpfile_stdout 02:32:39 INFO - Output received: 02:32:39 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) 02:32:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:32:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:39 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 0x103ca7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103caa768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb04045f820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a85d30>, '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 0x1039acdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a7abe8>, '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.ezIfkbM4cX/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.iyXwnWOk3i/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/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 02:32:39 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 02:32:39 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 02:32:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ezIfkbM4cX/Render', 02:32:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:32:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:32:39 INFO - 'HOME': '/Users/cltbld', 02:32:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:32:39 INFO - 'LOGNAME': 'cltbld', 02:32:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:39 INFO - 'MOZ_NO_REMOTE': '1', 02:32:39 INFO - 'NO_EM_RESTART': '1', 02:32:39 INFO - 'PAGER': '/bin/cat', 02:32:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:32:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:39 INFO - 'PWD': '/builds/slave/test', 02:32:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:32:39 INFO - 'SHELL': '/bin/bash', 02:32:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iyXwnWOk3i/Listeners', 02:32:39 INFO - 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/', 02:32:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:32:39 INFO - 'USER': 'cltbld', 02:32:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:32:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:32:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:39 INFO - 'XPC_FLAGS': '0x0', 02:32:39 INFO - 'XPC_SERVICE_NAME': '0', 02:32:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:32:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:40 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 02:32:40 INFO - Cleaning up... 02:32:40 INFO - Return code: 0 02:32:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:32:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103ca7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103caa768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb04045f820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a85d30>, '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 0x1039acdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a7abe8>, '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.ezIfkbM4cX/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.iyXwnWOk3i/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/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 02:32:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:32:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:32:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ezIfkbM4cX/Render', 02:32:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:32:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:32:40 INFO - 'HOME': '/Users/cltbld', 02:32:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:32:40 INFO - 'LOGNAME': 'cltbld', 02:32:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:40 INFO - 'MOZ_NO_REMOTE': '1', 02:32:40 INFO - 'NO_EM_RESTART': '1', 02:32:40 INFO - 'PAGER': '/bin/cat', 02:32:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:32:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:40 INFO - 'PWD': '/builds/slave/test', 02:32:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:32:40 INFO - 'SHELL': '/bin/bash', 02:32:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iyXwnWOk3i/Listeners', 02:32:40 INFO - 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/', 02:32:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:32:40 INFO - 'USER': 'cltbld', 02:32:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:32:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:32:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:40 INFO - 'XPC_FLAGS': '0x0', 02:32:40 INFO - 'XPC_SERVICE_NAME': '0', 02:32:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:32:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:40 INFO - Downloading/unpacking psutil>=3.1.1 02:32: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 02:32: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 02:32: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 02:32: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 02:32: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 02:32: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 02:32:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:32:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:32:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:32:44 INFO - Installing collected packages: psutil 02:32:44 INFO - Running setup.py install for psutil 02:32:44 INFO - building 'psutil._psutil_osx' extension 02:32:44 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 02:32:44 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 02:32:44 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 02:32:44 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 02:32:44 INFO - building 'psutil._psutil_posix' extension 02:32:44 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 02:32:44 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:32:44 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:32:44 INFO - ^ 02:32:44 INFO - 1 warning generated. 02:32:44 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 02:32:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:32:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:32:45 INFO - Successfully installed psutil 02:32:45 INFO - Cleaning up... 02:32:45 INFO - Return code: 0 02:32:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:32:45 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')]} 02:32:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:45 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')]} 02:32:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:45 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 0x103ca7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103caa768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb04045f820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a85d30>, '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 0x1039acdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a7abe8>, '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.ezIfkbM4cX/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.iyXwnWOk3i/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/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 02:32:45 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 02:32:45 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 02:32:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ezIfkbM4cX/Render', 02:32:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:32:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:32:45 INFO - 'HOME': '/Users/cltbld', 02:32:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:32:45 INFO - 'LOGNAME': 'cltbld', 02:32:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:45 INFO - 'MOZ_NO_REMOTE': '1', 02:32:45 INFO - 'NO_EM_RESTART': '1', 02:32:45 INFO - 'PAGER': '/bin/cat', 02:32:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:32:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:45 INFO - 'PWD': '/builds/slave/test', 02:32:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:32:45 INFO - 'SHELL': '/bin/bash', 02:32:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iyXwnWOk3i/Listeners', 02:32:45 INFO - 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/', 02:32:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:32:45 INFO - 'USER': 'cltbld', 02:32:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:32:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:32:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:45 INFO - 'XPC_FLAGS': '0x0', 02:32:45 INFO - 'XPC_SERVICE_NAME': '0', 02:32:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:32:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:32:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:32:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:32:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:32:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:32:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:32:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:32:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:32:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:32:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:32:48 INFO - Installing collected packages: mozsystemmonitor 02:32:48 INFO - Running setup.py install for mozsystemmonitor 02:32:48 INFO - Successfully installed mozsystemmonitor 02:32:48 INFO - Cleaning up... 02:32:48 INFO - Return code: 0 02:32:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:32:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:48 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 0x103ca7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103caa768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb04045f820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a85d30>, '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 0x1039acdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a7abe8>, '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.ezIfkbM4cX/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.iyXwnWOk3i/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/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 02:32:48 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 02:32:48 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 02:32:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ezIfkbM4cX/Render', 02:32:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:32:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:32:48 INFO - 'HOME': '/Users/cltbld', 02:32:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:32:48 INFO - 'LOGNAME': 'cltbld', 02:32:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:48 INFO - 'MOZ_NO_REMOTE': '1', 02:32:48 INFO - 'NO_EM_RESTART': '1', 02:32:48 INFO - 'PAGER': '/bin/cat', 02:32:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:32:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:48 INFO - 'PWD': '/builds/slave/test', 02:32:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:32:48 INFO - 'SHELL': '/bin/bash', 02:32:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iyXwnWOk3i/Listeners', 02:32:48 INFO - 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/', 02:32:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:32:48 INFO - 'USER': 'cltbld', 02:32:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:32:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:32:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:48 INFO - 'XPC_FLAGS': '0x0', 02:32:48 INFO - 'XPC_SERVICE_NAME': '0', 02:32:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:32:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:48 INFO - Downloading/unpacking jsonschema==2.5.1 02:32:48 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 02:32:48 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 02:32:48 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 02:32:48 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 02:32:48 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 02:32:48 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 02:32:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:32:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:32:51 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 02:32:51 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 02:32:51 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 02:32:51 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 02:32:51 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 02:32:51 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 02:32:51 INFO - Downloading functools32-3.2.3-2.tar.gz 02:32:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:32:51 INFO - warning: no files found matching '*.txt' 02:32:51 INFO - no previously-included directories found matching 'build' 02:32:51 INFO - no previously-included directories found matching 'dist' 02:32:51 INFO - no previously-included directories found matching '.git*' 02:32:51 INFO - Installing collected packages: jsonschema, functools32 02:32:51 INFO - Running setup.py install for functools32 02:32:51 INFO - warning: no files found matching '*.txt' 02:32:51 INFO - no previously-included directories found matching 'build' 02:32:51 INFO - no previously-included directories found matching 'dist' 02:32:51 INFO - no previously-included directories found matching '.git*' 02:32:51 INFO - Successfully installed jsonschema functools32 02:32:51 INFO - Cleaning up... 02:32:52 INFO - Return code: 0 02:32:52 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:32:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103ca7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103caa768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb04045f820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a85d30>, '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 0x1039acdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a7abe8>, '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.ezIfkbM4cX/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.iyXwnWOk3i/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/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 02:32:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:32:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:32:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ezIfkbM4cX/Render', 02:32:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:32:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:32:52 INFO - 'HOME': '/Users/cltbld', 02:32:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:32:52 INFO - 'LOGNAME': 'cltbld', 02:32:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:52 INFO - 'MOZ_NO_REMOTE': '1', 02:32:52 INFO - 'NO_EM_RESTART': '1', 02:32:52 INFO - 'PAGER': '/bin/cat', 02:32:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:32:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:52 INFO - 'PWD': '/builds/slave/test', 02:32:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:32:52 INFO - 'SHELL': '/bin/bash', 02:32:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iyXwnWOk3i/Listeners', 02:32:52 INFO - 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/', 02:32:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:32:52 INFO - 'USER': 'cltbld', 02:32:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:32:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:32:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:52 INFO - 'XPC_FLAGS': '0x0', 02:32:52 INFO - 'XPC_SERVICE_NAME': '0', 02:32:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:32:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:32:52 INFO - Cleaning up... 02:32:52 INFO - Return code: 0 02:32:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:32:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103ca7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103caa768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb04045f820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a85d30>, '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 0x1039acdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a7abe8>, '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.ezIfkbM4cX/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.iyXwnWOk3i/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/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 02:32:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:32:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:32:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ezIfkbM4cX/Render', 02:32:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:32:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:32:52 INFO - 'HOME': '/Users/cltbld', 02:32:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:32:52 INFO - 'LOGNAME': 'cltbld', 02:32:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:52 INFO - 'MOZ_NO_REMOTE': '1', 02:32:52 INFO - 'NO_EM_RESTART': '1', 02:32:52 INFO - 'PAGER': '/bin/cat', 02:32:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:32:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:52 INFO - 'PWD': '/builds/slave/test', 02:32:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:32:52 INFO - 'SHELL': '/bin/bash', 02:32:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iyXwnWOk3i/Listeners', 02:32:52 INFO - 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/', 02:32:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:32:52 INFO - 'USER': 'cltbld', 02:32:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:32:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:32:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:52 INFO - 'XPC_FLAGS': '0x0', 02:32:52 INFO - 'XPC_SERVICE_NAME': '0', 02:32:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:32:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:52 INFO - Downloading/unpacking blobuploader==1.2.4 02:32:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:32:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:32:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:32:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:32:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:32:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:32:55 INFO - Downloading blobuploader-1.2.4.tar.gz 02:32:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:32:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:32:55 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 02:32:55 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 02:32:55 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 02:32:55 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 02:32:55 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 02:32:55 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 02:32:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:32:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:32:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:32:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:32:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:32:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:32:56 INFO - Downloading docopt-0.6.1.tar.gz 02:32:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:32:56 INFO - Installing collected packages: blobuploader, requests, docopt 02:32:56 INFO - Running setup.py install for blobuploader 02:32:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:32:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:32:56 INFO - Running setup.py install for requests 02:32:57 INFO - Running setup.py install for docopt 02:32:57 INFO - Successfully installed blobuploader requests docopt 02:32:57 INFO - Cleaning up... 02:32:57 INFO - Return code: 0 02:32:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:32:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:57 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 0x103ca7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103caa768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb04045f820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a85d30>, '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 0x1039acdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a7abe8>, '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.ezIfkbM4cX/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.iyXwnWOk3i/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/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 02:32:57 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 02:32:57 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 02:32:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ezIfkbM4cX/Render', 02:32:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:32:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:32:57 INFO - 'HOME': '/Users/cltbld', 02:32:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:32:57 INFO - 'LOGNAME': 'cltbld', 02:32:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:57 INFO - 'MOZ_NO_REMOTE': '1', 02:32:57 INFO - 'NO_EM_RESTART': '1', 02:32:57 INFO - 'PAGER': '/bin/cat', 02:32:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:32:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:57 INFO - 'PWD': '/builds/slave/test', 02:32:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:32:57 INFO - 'SHELL': '/bin/bash', 02:32:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iyXwnWOk3i/Listeners', 02:32:57 INFO - 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/', 02:32:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:32:57 INFO - 'USER': 'cltbld', 02:32:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:32:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:32:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:57 INFO - 'XPC_FLAGS': '0x0', 02:32:57 INFO - 'XPC_SERVICE_NAME': '0', 02:32:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:32:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:32:57 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-PM_4mL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:32:57 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-kttTHL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:32:58 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-ZTZcNA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:32:58 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-1FDbHo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:32:58 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-Rg2453-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:32:58 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-JLcpcd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:32:58 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-oftRit-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:32:58 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-YHEqpQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:32:58 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-HkQ6Oq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:32:58 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-CZ3peM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:32:58 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-oRt31_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:32:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:32:59 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-v2qy4Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:32:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:32:59 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-FshJm8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:32:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:32:59 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-9cvIHS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:32:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:32:59 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-6JIZuj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:32:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:32:59 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-zB8xxJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:32:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:32:59 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-2qmYqT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:32:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:32:59 INFO - Running setup.py install for manifestparser 02:32:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:32:59 INFO - Running setup.py install for mozcrash 02:32:59 INFO - Running setup.py install for mozdebug 02:33:00 INFO - Running setup.py install for mozdevice 02:33:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:33:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:33:00 INFO - Running setup.py install for mozfile 02:33:00 INFO - Running setup.py install for mozhttpd 02:33:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:33:00 INFO - Running setup.py install for mozinfo 02:33:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:33:00 INFO - Running setup.py install for mozInstall 02:33:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:33:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:33:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:33:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:33:00 INFO - Running setup.py install for mozleak 02:33:00 INFO - Running setup.py install for mozlog 02:33:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:33:01 INFO - Running setup.py install for moznetwork 02:33:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:33:01 INFO - Running setup.py install for mozprocess 02:33:01 INFO - Running setup.py install for mozprofile 02:33:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:33:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:33:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:33:01 INFO - Running setup.py install for mozrunner 02:33:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:33:01 INFO - Running setup.py install for mozscreenshot 02:33:01 INFO - Running setup.py install for moztest 02:33:02 INFO - Running setup.py install for mozversion 02:33:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:33:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:33:02 INFO - Cleaning up... 02:33:02 INFO - Return code: 0 02:33:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:33:02 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')]} 02:33:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:02 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')]} 02:33:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:02 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 0x103ca7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103caa768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb04045f820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a85d30>, '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 0x1039acdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a7abe8>, '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.ezIfkbM4cX/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.iyXwnWOk3i/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/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 02:33:02 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 02:33:02 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 02:33:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ezIfkbM4cX/Render', 02:33:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:33:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:33:02 INFO - 'HOME': '/Users/cltbld', 02:33:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:33:02 INFO - 'LOGNAME': 'cltbld', 02:33:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:02 INFO - 'MOZ_NO_REMOTE': '1', 02:33:02 INFO - 'NO_EM_RESTART': '1', 02:33:02 INFO - 'PAGER': '/bin/cat', 02:33:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:33:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:02 INFO - 'PWD': '/builds/slave/test', 02:33:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:33:02 INFO - 'SHELL': '/bin/bash', 02:33:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iyXwnWOk3i/Listeners', 02:33:02 INFO - 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/', 02:33:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:33:02 INFO - 'USER': 'cltbld', 02:33:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:33:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:33:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:02 INFO - 'XPC_FLAGS': '0x0', 02:33:02 INFO - 'XPC_SERVICE_NAME': '0', 02:33:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:33:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:33:02 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-2X7MZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:33:02 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)) 02:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:33:02 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-wL8twe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:33:02 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)) 02:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:33:02 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-l2VPK1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:33:02 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)) 02:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:33:02 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-Wfx6YH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:33:02 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)) 02:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:33:02 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-aWUs1L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:33:03 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)) 02:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:33:03 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-yUOBPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:33:03 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)) 02:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:33:03 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-JzVSWm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:33:03 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)) 02:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:33:03 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-PBNFXm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:33:03 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)) 02:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:33:03 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-BnYByP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:33:03 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)) 02:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:33:03 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-AQltwQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:33:03 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)) 02:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:33:03 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-gECA4v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:33:03 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)) 02:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:33:03 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-pR35m4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:33:03 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)) 02:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:33:03 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-NsevEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:33:03 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)) 02:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:33:03 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-pDcSel-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:33:03 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)) 02:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:33:03 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-xq5zhV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:33:04 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)) 02:33:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:33:04 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-4A_V6q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:33:04 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)) 02:33:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:33:04 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-AXw2EA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:33:04 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)) 02:33:04 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)) 02:33:04 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)) 02:33:04 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)) 02:33:04 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)) 02:33:04 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)) 02:33:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:33:04 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 02:33:04 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 02:33:04 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 02:33:04 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 02:33:04 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 02:33:04 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 02:33:06 INFO - Downloading blessings-1.6.tar.gz 02:33:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:33:07 INFO - Installing collected packages: blessings 02:33:07 INFO - Running setup.py install for blessings 02:33:07 INFO - Successfully installed blessings 02:33:07 INFO - Cleaning up... 02:33:07 INFO - Return code: 0 02:33:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:33:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:33:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:33:07 INFO - Reading from file tmpfile_stdout 02:33:07 INFO - Current package versions: 02:33:07 INFO - blessings == 1.6 02:33:07 INFO - blobuploader == 1.2.4 02:33:07 INFO - docopt == 0.6.1 02:33:07 INFO - functools32 == 3.2.3-2 02:33:07 INFO - jsonschema == 2.5.1 02:33:07 INFO - manifestparser == 1.1 02:33:07 INFO - mozInstall == 1.12 02:33:07 INFO - mozcrash == 1.0 02:33:07 INFO - mozdebug == 0.1 02:33:07 INFO - mozdevice == 0.49 02:33:07 INFO - mozfile == 1.2 02:33:07 INFO - mozhttpd == 0.7 02:33:07 INFO - mozinfo == 0.9 02:33:07 INFO - mozleak == 0.1 02:33:07 INFO - mozlog == 3.4 02:33:07 INFO - moznetwork == 0.27 02:33:07 INFO - mozprocess == 0.24 02:33:07 INFO - mozprofile == 0.28 02:33:07 INFO - mozrunner == 6.13 02:33:07 INFO - mozscreenshot == 0.1 02:33:07 INFO - mozsystemmonitor == 0.3 02:33:07 INFO - moztest == 0.8 02:33:07 INFO - mozversion == 1.4 02:33:07 INFO - psutil == 3.1.1 02:33:07 INFO - requests == 1.2.3 02:33:07 INFO - wsgiref == 0.1.2 02:33:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:33:07 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')]} 02:33:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:07 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')]} 02:33:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:07 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 0x103ca7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103caa768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb04045f820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a85d30>, '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 0x1039acdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a7abe8>, '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.ezIfkbM4cX/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.iyXwnWOk3i/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/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 02:33:07 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 02:33:07 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 02:33:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ezIfkbM4cX/Render', 02:33:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:33:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:33:07 INFO - 'HOME': '/Users/cltbld', 02:33:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:33:07 INFO - 'LOGNAME': 'cltbld', 02:33:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:07 INFO - 'MOZ_NO_REMOTE': '1', 02:33:07 INFO - 'NO_EM_RESTART': '1', 02:33:07 INFO - 'PAGER': '/bin/cat', 02:33:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:33:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:07 INFO - 'PWD': '/builds/slave/test', 02:33:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:33:07 INFO - 'SHELL': '/bin/bash', 02:33:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iyXwnWOk3i/Listeners', 02:33:07 INFO - 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/', 02:33:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:33:07 INFO - 'USER': 'cltbld', 02:33:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:33:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:33:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:07 INFO - 'XPC_FLAGS': '0x0', 02:33:07 INFO - 'XPC_SERVICE_NAME': '0', 02:33:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:33:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:07 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)) 02:33:07 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)) 02:33:07 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)) 02:33:07 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)) 02:33:07 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)) 02:33:07 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)) 02:33:07 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)) 02:33:07 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)) 02:33:07 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)) 02:33:07 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)) 02:33:07 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)) 02:33:07 INFO - Cleaning up... 02:33:07 INFO - Return code: 0 02:33:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:33:07 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')]} 02:33:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:07 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')]} 02:33:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:07 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 0x103ca7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103caa768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb04045f820>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a85d30>, '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 0x1039acdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a7abe8>, '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.ezIfkbM4cX/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.iyXwnWOk3i/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/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 02:33:07 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 02:33:07 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 02:33:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ezIfkbM4cX/Render', 02:33:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:33:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:33:07 INFO - 'HOME': '/Users/cltbld', 02:33:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:33:07 INFO - 'LOGNAME': 'cltbld', 02:33:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:07 INFO - 'MOZ_NO_REMOTE': '1', 02:33:07 INFO - 'NO_EM_RESTART': '1', 02:33:07 INFO - 'PAGER': '/bin/cat', 02:33:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:33:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:07 INFO - 'PWD': '/builds/slave/test', 02:33:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:33:07 INFO - 'SHELL': '/bin/bash', 02:33:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iyXwnWOk3i/Listeners', 02:33:07 INFO - 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/', 02:33:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:33:07 INFO - 'USER': 'cltbld', 02:33:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:33:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:33:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:07 INFO - 'XPC_FLAGS': '0x0', 02:33:07 INFO - 'XPC_SERVICE_NAME': '0', 02:33:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:33:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:33:08 INFO - Cleaning up... 02:33:08 INFO - Return code: 0 02:33:08 INFO - Running post-action listener: _resource_record_post_action 02:33:08 INFO - Running post-action listener: _start_resource_monitoring 02:33:08 INFO - Starting resource monitoring. 02:33:08 INFO - [mozharness: 2017-02-24 10:33:08.128325Z] Finished create-virtualenv step (success) 02:33:08 INFO - [mozharness: 2017-02-24 10:33:08.129279Z] Running install step. 02:33:08 INFO - Running pre-action listener: _resource_record_pre_action 02:33:08 INFO - Running main action method: install 02:33:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:33:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:33:08 INFO - Reading from file tmpfile_stdout 02:33:08 INFO - Detecting whether we're running mozinstall >=1.0... 02:33:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:33:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:33:08 INFO - Reading from file tmpfile_stdout 02:33:08 INFO - Output received: 02:33:08 INFO - Usage: mozinstall [options] installer 02:33:08 INFO - Options: 02:33:08 INFO - -h, --help show this help message and exit 02:33:08 INFO - -d DEST, --destination=DEST 02:33:08 INFO - Directory to install application into. [default: 02:33:08 INFO - "/builds/slave/test"] 02:33:08 INFO - --app=APP Application being installed. [default: firefox] 02:33:08 INFO - mkdir: /builds/slave/test/build/application 02:33:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:33:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 02:33:28 INFO - Reading from file tmpfile_stdout 02:33:28 INFO - Output received: 02:33:28 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:33:28 INFO - Running post-action listener: _resource_record_post_action 02:33:28 INFO - [mozharness: 2017-02-24 10:33:28.651423Z] Finished install step (success) 02:33:28 INFO - [mozharness: 2017-02-24 10:33:28.651557Z] Running run-tests step. 02:33:28 INFO - Running pre-action listener: _resource_record_pre_action 02:33:28 INFO - Running main action method: run_tests 02:33:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:33:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:33:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:33:28 INFO - 2017-02-24 02:33:28.666 screenresolution[2004:23738] starting screenresolution argv=screenresolution get 02:33:28 INFO - 2017-02-24 02:33:28.668 screenresolution[2004:23738] Display 0: 1600x1200x32@60 02:33:28 INFO - 2017-02-24 02:33:28.674 screenresolution[2005:23741] starting screenresolution argv=screenresolution list 02:33:28 INFO - Available Modes on Display 0 02:33:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:33:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:33:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:33:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:33:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:33:28 INFO - Intel Iris: 02:33:28 INFO - Chipset Model: Intel Iris 02:33:28 INFO - Type: GPU 02:33:28 INFO - Bus: Built-In 02:33:28 INFO - VRAM (Dynamic, Max): 1536 MB 02:33:28 INFO - Vendor: Intel (0x8086) 02:33:28 INFO - Device ID: 0x0a2e 02:33:28 INFO - Revision ID: 0x0009 02:33:28 INFO - Displays: 02:33:28 INFO - Display: 02:33:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:33:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:33:28 INFO - Display Serial Number: 1600x1200 60 02:33:28 INFO - Main Display: Yes 02:33:28 INFO - Mirror: Off 02:33:28 INFO - Online: Yes 02:33:28 INFO - Rotation: Supported 02:33:28 INFO - Return code: 0 02:33:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:33:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:33:28 INFO - Python 2.7.3 02:33:28 INFO - Return code: 0 02:33:28 INFO - grabbing minidump binary from tooltool 02:33: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')]} 02:33:28 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 0x103a85d30>, '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 0x1039acdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a7abe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:33:28 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 02:33:28 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 02:33:28 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 02:33:28 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:33:29 INFO - Return code: 0 02:33:29 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:33:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:33:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:33:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:33:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:33:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CS6MS_A5TtS3pYoG46LpVg/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0374', '--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 02:33:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CS6MS_A5TtS3pYoG46LpVg/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0374 --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 02:33:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ezIfkbM4cX/Render', 02:33:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:33:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:33:29 INFO - 'HOME': '/Users/cltbld', 02:33:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:33:29 INFO - 'LOGNAME': 'cltbld', 02:33:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:33:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:33:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:29 INFO - 'MOZ_NO_REMOTE': '1', 02:33:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:33:29 INFO - 'NO_EM_RESTART': '1', 02:33:29 INFO - 'PAGER': '/bin/cat', 02:33:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:33:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:29 INFO - 'PWD': '/builds/slave/test', 02:33:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:33:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:33:29 INFO - 'SHELL': '/bin/bash', 02:33:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iyXwnWOk3i/Listeners', 02:33:29 INFO - 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/', 02:33:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:33:29 INFO - 'USER': 'cltbld', 02:33:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:33:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:33:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:29 INFO - 'XPC_FLAGS': '0x0', 02:33:29 INFO - 'XPC_SERVICE_NAME': '0', 02:33:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:33:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CS6MS_A5TtS3pYoG46LpVg/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0374', '--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 02:33:29 INFO - mozversion application_buildid: 20170224004003 02:33:29 INFO - mozversion application_changeset: 883dd404cfa2bab84de402e87484e1b2b268f466 02:33:29 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:33:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:33:29 INFO - mozversion application_name: Firefox 02:33:29 INFO - mozversion application_remotingname: firefox-dev 02:33:29 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:33:29 INFO - mozversion application_vendor: Mozilla 02:33:29 INFO - mozversion application_version: 53.0a2 02:33:29 INFO - mozversion platform_buildid: 20170224004003 02:33:29 INFO - mozversion platform_changeset: 883dd404cfa2bab84de402e87484e1b2b268f466 02:33:29 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:33:29 INFO - mozversion platform_version: 53.0a2 02:33:29 INFO - using testdate: 1487932409 02:33:29 INFO - actual date: 1487932409 02:33:29 INFO - starting webserver on 'localhost:52849' 02:33:29 INFO - SUITE-START | Running 2 tests 02:33:29 INFO - TEST-START | dromaeo_css 02:33:29 INFO - operating with platform_type : mac_ 02:33:29 INFO - Initialising browser for dromaeo_css test... 02:33:29 INFO - TEST-INFO | started process 2015 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/tmpNIzceI/profile http://localhost:52849/getInfo.html) 02:33:32 INFO - PROCESS | 2015 | 2017-02-24 02:33:32.114 plugin-container[2018:23915] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c4f, name = 'com.apple.tsm.portname' 02:33:32 INFO - PROCESS | 2015 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:33:32 INFO - PROCESS | 2015 | 2017-02-24 02:33:32.114 plugin-container[2018:23915] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x970b, name = 'com.apple.CFPasteboardClient' 02:33:32 INFO - PROCESS | 2015 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:33:32 INFO - PROCESS | 2015 | 2017-02-24 02:33:32.114 plugin-container[2018:23915] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:33:32 INFO - PROCESS | 2015 | __metrics Screen width/height:1600/1200 02:33:32 INFO - PROCESS | 2015 | colorDepth:24 02:33:32 INFO - PROCESS | 2015 | Browser inner width/height: 1024/689 02:33:32 INFO - PROCESS | 2015 | __metrics 02:33:32 ERROR - PROCESS | 2015 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 02:33:33 INFO - TEST-INFO | 2015: exit 0 02:33:33 INFO - Browser initialized. 02:33:33 INFO - Running cycle 1/1 for dromaeo_css test... 02:33:33 INFO - TEST-INFO | started process 2019 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/tmpNIzceI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:33:35 INFO - PROCESS | 2019 | 2017-02-24 02:33:35.713 plugin-container[2020:24052] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4547, name = 'com.apple.tsm.portname' 02:33:35 INFO - PROCESS | 2019 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:33:35 INFO - PROCESS | 2019 | 2017-02-24 02:33:35.714 plugin-container[2020:24052] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 02:33:35 INFO - PROCESS | 2019 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:33:35 INFO - PROCESS | 2019 | 2017-02-24 02:33:35.714 plugin-container[2020:24052] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:33:45 INFO - PROCESS | 2019 | RSS: Main: 218918912 02:33:45 INFO - PROCESS | 2019 | 02:36:47 INFO - PROCESS | 2019 | Cycle 1(1): loaded http://localhost:52849/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52849/tests/dromaeo/cssquery-ext.html) 02:36:49 INFO - PROCESS | 2019 | RSS: Main: 239357952 02:36:49 INFO - PROCESS | 2019 | 02:38:33 INFO - PROCESS | 2019 | ************************* 02:38:33 INFO - PROCESS | 2019 | A coding exception was thrown and uncaught in a Task. 02:38:33 INFO - PROCESS | 2019 | 02:38:33 ERROR - PROCESS | 2019 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:38:33 INFO - PROCESS | 2019 | Full stack: 02:38:33 INFO - PROCESS | 2019 | ************************* 02:39:51 INFO - PROCESS | 2019 | Cycle 1(1): loaded http://localhost:52849/tests/dromaeo/cssquery-ext.html (next: http://localhost:52849/tests/dromaeo/cssquery-jquery.html) 02:39:52 INFO - PROCESS | 2019 | RSS: Main: 251084800 02:39:52 INFO - PROCESS | 2019 | 02:42:54 INFO - PROCESS | 2019 | Cycle 1(1): loaded http://localhost:52849/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52849/tests/dromaeo/cssquery-mootools.html) 02:42:54 INFO - PROCESS | 2019 | RSS: Main: 259948544 02:42:54 INFO - PROCESS | 2019 | 02:45:56 INFO - PROCESS | 2019 | Cycle 1(1): loaded http://localhost:52849/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52849/tests/dromaeo/cssquery-prototype.html) 02:45:57 INFO - PROCESS | 2019 | RSS: Main: 256413696 02:45:57 INFO - PROCESS | 2019 | 02:49:00 INFO - PROCESS | 2019 | Cycle 1(1): loaded http://localhost:52849/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52849/tests/dromaeo/cssquery-yui.html) 02:49:00 INFO - PROCESS | 2019 | RSS: Main: 260276224 02:49:00 INFO - PROCESS | 2019 | 02:52:03 INFO - PROCESS | 2019 | Cycle 1(1): loaded http://localhost:52849/tests/dromaeo/cssquery-yui.html (next: http://localhost:52849/tests/dromaeo/cssquery-dojo.html) 02:52:03 INFO - PROCESS | 2019 | RSS: Main: 261353472 02:52:03 INFO - PROCESS | 2019 | 02:52:03 INFO - PROCESS | 2019 | __start_tp_report 02:52:03 INFO - PROCESS | 2019 | _x_x_mozilla_page_load 02:52:03 INFO - PROCESS | 2019 | _x_x_mozilla_page_load_details 02:52:03 INFO - PROCESS | 2019 | |i|pagename|runs| 02:52:03 INFO - PROCESS | 2019 | |0;dojo.html;2982.7315541601265;3017.8340191289476;3054.755619550436;3373.9999999999986;3393.2365217825977;5677.602567820254;5712.371639119693;5713.428657134285;5737.885242295151;5742.454466825655;4815.638827087965;5723.685197314146;5760.683162426065;5808.506276966453;5815.534757219423;5237.083510385686;5262.578993680516;5331.786728530874;5332.706701131437;5342.786288548473;5353.625246232766;5363.410024897277;5366.141417373221;5385.407605163429;5387.111126664116;5182.093133701606;5214.348206474191;5346.4118946915805;5356.38401583819;5367.516923476886;5250.737463126848;5252.579793616502;5267.578593712494;5313.149896016619;5351.812686555952;5144.819931302386;5228.980348831979;5237.659552129099;5242.9213561796605;5346.117890548055;5534.501894829485;5687.146927960797;5765.88468230633;5851.3270973838125;5858.033424484955;6144.341027922481;6176.320604733521;6178.474829639486;6246.25044994599;6348.809535713936;6288.151099601541;6312.147860038882;6320.873582528324;6323.462505687022;6361.55469117162;5884.176215329857;5914.112883067488;5920.289565252154;5920.792772252994;5945.970270148621;6233.2208473940755;6261.9373806262265;6276.309605943343;6280.5603607747935;6286.937130628727;6175.382461753788;6184.721687524072;6209.751609935643;6222.657753823583;6224.533160013018;6300.086487459384;6307.905381419282;6310.6213627182515;6319.115323854664;6323.462505687068;6131.437835141539;6164.876702466016;6209.627422354673;6218.440340369389;6222.3466536013975;5521.503064724194;6285.151504546919;6304.684765761694;6317.778877739257;6317.810465686037;5006.69959802413;5021.071101846097;5029.5724863386295;5045.066662667345;5046.873828154326;4359.367891655692;4409.757463339547;4435.600795928317;4505.43682039745;4517.977410112929;5768.451997060357;5807.912881306784;5846.912296315559;5874.765009399662;5935.109733539917;6279.309275979638;6279.309275979638;6282.748690052438;6288.748450061947;6325.841853953596;5639.971800141055;5675.77296908119;5701.144828275709;5716.685582293014;5753.453421924911;5456.672599644034;5463.2078348639225;5474.206240095164;5478.534324582375;5481.890362192734;6326.746930122744;6330.303666596763;6333.619982801047;6340.080688300079;6351.110844481776;6156.661383623944;6195.380461953769;6196.969015154896;6265.592736472115;6284.654344011124;6326.8734625306315;6352.714127864349;6353.078803573549;6356.078368636614;6364.204474440695;5554.861128471821;6092.603980741238;6206.689665516797;6254;6256.217972753406;6096.420840020191;6162.044883043135;6236.594621349598;6305.464035557029;6382.106505089384;4840.588549973291;6139.570230083851;6229.096780966644;6236.18929539157;6252.312245652884;5587.966226248157;6173.629582225081;6201.689915504297;6237.033259844731;6239.96880015597;5867.73595188209;5926.733297001731;5967.389142970838;6035.18524999137;6122.173506576733;6133.304060594526;6134.8159555213415;6140.109684095871;6187.504999599932;6201.10084037803;5981;6013;6041.4148578050135;6045.153678485103;6056.757729690939 02:52:03 INFO - PROCESS | 2019 | |1;ext.html;440.407651708452;495.7843338147905;498.8353843231734;512.5873671694286;534.599050711966;39276.821695349114;42500;42507;42536;42569;42395.9401014974;43009.569904300944;43074;43160;43206.783966080206;8459.53472559009;9172.908270917289;9405.85891211629;9435.481048542328;9437;8446.155384461536;11368.60209892654;11613.245139065975;11649.359285239309;11834.8224776628;11642.592509262178;11681.065514758842;11717.355545444998;11734.29594224345;11738;11634;11674.70813229676;11715.121365897592;11716.82424763625;11736.647900562912;11546.53813847445;11627.418629068512;11639;11643.18497705161;11651.300921944625;41527.7923610383;41639;41792.582074179474;41902.580974190176;41911.7904410476;3391.5082313064713;3953.8290963807576;3960.722749407543;3970.66249368804;3990.3016972029777;30248.697513024807;31344.37311253785;31368;32055.03834884957;32069;3205.5031470121935;3220.516922461626;3231.676832316773;3231.8384080795868;3260.10347154532;337736;338279;338944.3052784745;339558;341672;68675.65662171657;68940;69211.3078869215;69231;69543.65228173826;72005.6399717998;72254;72400.63799680967;72481;72829.90755138677;16775;17412.21645025977;17450.47648570545;17453.563660908578;17495.30018799234;11704.531818727155;12238.877611223774;12896.161749486253;13130.212187268795;13210.339483026002;18799.530011749815;19386.321478748458;19402.611947760965;19503.024848757505;19552.804471955384;6764.458843292525;7034.80408330585;7105.75129870452;7110.253423390573;7135.179454362711;721.6577166470361;856.6873091321747;861.4357595774777;872.1540106097076;883.0904168706243;29780.40439191204;30128.84935575352;30490.847545762128;31134.532982005287;31569;937.2970272295778;1037.3775734559204;1066.1044722433194;1068.6497829305029;1165.5745652836654;13879.167249965034;14434.061785983877;14448.494302699355;15427.382904683911;16402.425915093154;391987;394890;396882;397468;397750;57983.420165797805;58405;58436;58561;58623;1402.9859701403059;1434.103685196752;1439.8632129947848;1458.6645071633584;1461.5761429185418;29427.970021050016;30150.84924575363;30212.69787302187;30583.388332232786;30712.925047623226;49694;49763;50170.996580068924;50186.49813501964;50295.99408011746;315833;316263;316978;317512;363442;25552.488950221265;26383.208503744918;26421.867890660425;38999.22001559896;39449.80275098606;42634.360484592136;42811;44369.556304437836;44528.332075018254;44717.32924006208;34308.14229644279;35406.64593354137;35693.82153089218;36220.637793621725;36420;35583.82208088943;36152.8192359047;36335.636643633225;36366.63633363633;36589.08527286839;34816;34993.475097873044;35115.64884351226;35512.28975420529;35776.82111589425;29782;30222.84888575543;32260.19349516187;33009.67961281522;33305;19435.63665370437;24767;24820.25539233826;25070.37324066913;25239.864206111135 02:52:03 INFO - PROCESS | 2019 | |2;jquery.html;309.92097015261106;352.088091842129;399.99800499748125;400.489376045542;408.0736727628282;17181.48455546334;19768.505787355305;20043.298484553045;20157.596848063065;20936.057877395517;17879;20277.290294839648;20303.39089827304;20798.48003799906;20886.686699699516;4272.401863739079;5008.348914641091;5496.80761173359;5499;5503.532199763025;6010.57925945184;6181.289151747562;6205.286392064925;6206.906896396535;6211.254649442073;5183.792648294064;5697.202391665171;5996.4902983246475;6093.756249750005;6167.62994220346;5027.421846487664;5972.552058595601;6008.3390827009;6053.303870054956;6062.393760623946;5071.974640126813;5103.693778373272;5750.913736293959;5870.09013602888;6041.24484439445;21925.903704814697;22095.226667066574;24452.51094978108;25585.23244302674;25808.612870806952;2493.4140476987895;2599.233226198276;2626.8292560983473;2629.934251643705;2645.320221659241;9923.503824808731;10386.27296089274;10394.324368915995;11494.252873563191;14507.492237771732;1768.619746754454;1818.3453956575622;1835.5227640813484;1848.9630207395912;1856.1368963431935;103045;127377;131891;146451.99999999892;158349;11580.88419115798;11637.650870473899;11903.821442678367;11921.046316294676;12109.152359334763;15884.92057539705;16040.11779352147;16050.438234661964;16075.437359692589;16100.275487603087;8715.825683486295;8882.511461869659;8894.73315800527;8956.507392093497;8978.955105224431;8616.956915215384;8634.179752923463;8660.740177794676;8751.474911505331;8791.604377803014;4858.732769697701;4877.780499877443;4888.340074089952;4892.217245240744;4951.579115775127;2031.628650660798;2063.329417939176;2069.368842503051;2073.8133567978653;2074.8547601667738;942.79258563116;992.8135877626167;1006.3307900246255;1044.9164066874632;1066.8453074304339;17086.437034444934;21462.72533224536;22057.22799702003;22125.60096754523;22302.888485557793;930.4696323095906;1062.1396668698223;1091.247039542713;1098.1983152298867;1099.8130317845985;10967.561297548009;11627.6511704649;11630.53477860876;11696.70758231051;11701;428214;535402;665401.6729916319;765792;786642;151943;155923.6611450829;159622;168362;169978;1056.963006294776;1064.920130990179;1102.101787043557;1111.5331560744507;1112.0936436803818;20228.393148205578;20359.898200508902;20915.686264706346;20953.476163096046;21004.159833606485;49221;54222.18666719923;56184.719076404355;59580.19509812278;59737.40262597492;83969;86627.13372866191;87353.56323218343;87783.12216878004;88275.55862220647;8510.553205954879;8545.957270213858;8546.102659220693;8798.9881163667;8818.206361427503;12208.511659533518;12619.432125554189;13496;13555.728885422433;13787.896968242316;11102.555897764;11228.66314010581;11343.829842552534;11422.543098275975;11676;11608;11624.07007439386;11733.354665493138;11932.76134477323;12019.278843269432;11598.652040438801;11853.881461185278;11902.285862848257;11952.489977104906;12051.57819476314;8460.873086903825;8467.53428561435;8484.91515084866;8571.914280857362;8805.911940880766;8389.580520974048;10065.597376105166;11341.886581134084;11664.066874649838;11744.119191060876 02:52:03 INFO - PROCESS | 2019 | |3;mootools.html;1409.2037998530836;1409.6264489910175;1422.4594654031466;1437.4825062977327;1437.4896911596386;7545.849083018336;7785.493942893722;8041.638126284317;8483.91516084839;8490.872636910444;6958.478114141447;7799.10310314314;8045.477043992151;8107.22981316774;8219.342452603792;2301.5627030864166;2350.21267875262;2352.3883790214495;2353.329301149173;2358.3278765551822;1746.2491128814604;2063.814256716895;2326.674265602817;2364.3970787449175;2375.5961486547244;2248.9887550562225;2329.24299602629;2330.1029103795076;2340.3096086654477;2347.448349637834;2324.1633012115626;2335.35777661142;2344.3201471573225;2352.9646955339595;2354.5526349993447;2318.802901753353;2320.8491448055993;2383.642453631952;2384.7615238476187;2387.045181927243;8402.45384050041;8450.112738162466;8470.322374210049;8475.830483390358;8480.194381533744;4996.825111121129;5148.897022059537;5149.382074151126;5149.76826042829;5152.536271735525;3221.6295126060336;3394.6605339466105;3458.6195518492946;3494.0915362006062;3541.557305336833;1175.4357908204024;1191.845060142176;1227;1243.6952946528068;1260.023481801602;8786.209241168262;10843.620473283476;11003.394813285346;11014.614488492944;11017.394043327613;3402.965970340265;4305.579158877563;4696.8121275148615;4719.126961512131;4756.762161891892;9132.863007054899;9571.808563828823;9617.374870633386;9620.086091821266;9627.085426884434;4810.470848206694;4846.975765121222;5165.535101840777;5237.083510385667;5251.133562962068;4539.72761634303;4752.52474752522;4786.138495070921;4795.736234507136;4853.733044682576;3856.267309211241;3889.319369110451;3936.7637941723588;3985.4221137935415;4008.358662614026;1183.6153250193722;1224.5285565057518;1236.4992178167856;1259.8488181418106;1266.7529831682918;855.3713020929612;866.8743032260413;870.856308709056;884.7036242858586;894.338189739601;5715.799947001919;5727.971360143172;5759.136129580596;5766.308043034863;5998.580099393001;847.6905929335747;966.7003228998892;979.2459805949521;985.3890587835588;1015.4059874973076;3745.4569087482164;3780.4896338994436;3802.4676545283683;3872.128771026553;3875.9806200968815;9898.455584942898;10254.333468324536;10259.127974122282;10260.179185665129;10261.28171028021;10210.591576337012;10212.438315892548;10218.386896786216;10229.795404091876;10238.897611023795;7642.312191902755;7931.722389716332;7950.960245198737;7954.164812694699;7989.76030719091;5620.9156862647915;5668.064769313182;5705.144228365778;5762.481376676119;5763.106718458645;8624.956875215585;9241.953790231006;9296.349255552046;9299.535023248674;9392.342536022414;9120.315976301672;9354.76613084651;9430.575624096795;9495;9580.56887440053;7110.1112360954885;7275.563466192046;7419.8145046374275;7423.5917024562;7428.071491063617;7954.164812694584;8039.5176289422825;8085.716999904975;8114.431989760897;8132.390070744599;7197.208307086321;7265.673044712895;7335.816604584928;7336.633168341668;7393;5734.254546908875;7097.467689923174;7126.180489243803;7141.678624462015;7164.534305270141;5390.353157621111;6168.920438923081;6291.1192433058495;6361.01404282337;6453.354664533509;4309.2674245378985;4906.092372911023;4942.604591632733;4995.8001679932395;5065.544101030778;4371.956280437155;4921.95920322538;4997.9750101249265;5046.924296135634;5067.113255180402 02:52:03 INFO - PROCESS | 2019 | |4;prototype.html;351.6062010548185;356.58101730466694;362.33330671564323;366.05192551292146;368.3406702003413;4552.908941821166;4721.433427988646;4938.876528086796;5214.739263036852;5372.113601255793;4548.272276435771;4751.833685820997;4863.829765958192;5420.186971954209;5456.454354564542;3993.7204395692315;4120.134771697947;4123.319652257389;4309.741415515064;4314.748722870371;3888.1446081862086;4109.239790638741;4120.320147175712;4120.979395103021;4129.256733787917;3493.1616412061176;4052.8986775330704;4098.426220329141;4128.958710412902;4147.610550465598;3905.687544996422;4101.876943691694;4110.445089912853;4134.359174327984;4139.1100913303635;3404.570080566168;3475.113845969287;3499.8075105869166;3522.43641017436;3545.804980726059;4057.9594204057876;4808.807647694088;5076.086304465195;5224.712640804754;5287.206918962148;4231.619154276099;4422.867313980586;4686.742229177394;4706;4727.321800760715;4564.589186973189;5358.196270559409;5691.9146212806845;5748.19525266463;5780.855478613026;3377.5102610121394;3831.8695984684587;3942.467766851467;3971.920561588781;3983.40248962655;5083.872903177413;6041.127250552343;6051.909221361683;6086.543509236781;6100.359462256443;3429.8456569453933;3526.889029955556;3601.837917293728;3825.4835597194024;3950.7827069510877;3787.7348585599293;3898.3957486589625;4053.858114966021;4061.2080644274674;4088.856890008895;4034.3545032794614;4734.147853386424;4747.314703280285;4788.640851936118;4792.95207047932;4902.362692849907;5003.674761140514;5569.944300557024;5725.656460612377;5801.187833703285;1076.9192310576582;1311.76388250114;1313.1792629606496;1323.543377534749;1326.8009798530297;840.403313647305;876.3164731509432;887.2458410351279;897.4608546343053;906.2432868554699;4413.029133590605;4470.809303441355;4507.6168525675685;5111.412187598399;5168.870778230575;4937.432195297515;5654.717264136777;5758.337791154071;5770.711464426762;5784.652920824764;4382.408374869352;4814.470408255089;4965.187706487179;5186.325777648957;5194.662346947512;2425.4421483058995;2707.377303220231;2770.561905523167;2851.4744611632677;2962.5704272880744;5435.809746658848;5591.692456914909;5757.940651840442;5929.762809487658;5964.642121472725;5473.698946557977;5801.970990145022;5882.823515294548;5896.056630939029;5937.832691067815;5901.262342207224;5922.585419020627;5941.376155503696;5968.612554977956;5971.178790468949;5639.915401269066;5657.886842263049;5678.592844293391;5709.743061562157;5723.599348045597;4752.786124624331;4964.230544265644;5149.459306772735;5479.945200548103;5968.522518198621;6039.456448919618;6243.750249989949;6251.78118765841;6252.749890004349;6265.843353916189;3744.4570537271397;3973.6622387097423;3997.5003124609425;4003.299422600975;4029.49631296088;5348.732563371738;5637.098064309691;5853.502452291603;5899.410058994066;5974.1934838796205;5105.489451054865;5661.612904838341;5787.971060144672;5798.855028624318;5836.686745482232;5007;5216.269722238965;5325.520703136736;5755.251817263729;5843.328017277898;5268.604854635841;5624.634398764068;5626.831195064155;5636.915446268227;5664.320281566238;5201.514984960161;5343.465653434625;5688.886222275614;5796.913046304393;5810.477057064884;5472.088558677572;5493.983613031602;5649.71751412436;5659.971700141473;5724.713764311685 02:52:03 INFO - PROCESS | 2019 | |5;yui.html;734.3904559215852;735.8050116719068;751.4138971602152;814.5347886619136;825.6243409248791;14446;14867.851321486782;15303.540893773177;15339.386424543005;15343.00270482418;14043.016988810787;14124.788128178085;14245.14529128253;14303;14376.137431754101;857.2541888556949;868.6047848229073;869.9913000869974;870.6299822575412;871.930245580352;682.3074579301988;699.7341010416035;848.8047749017699;869.6217145541709;876.2639382918347;905.2531661379388;920.7283851263893;923.9861402078974;924.5931790012406;931.4690626342987;767.9040119985002;919.4758987377164;921.1019256225127;921.6958403726754;922.4004397141845;681.9897701534481;681.993180068198;682.1779755394787;682.7132604306204;684.0184335478555;14974.775378369333;14975.775363369557;15004.474843380429;15053.247337633074;15343.156126413043;14288.785668214985;14658.926705366512;14661.853381466262;14707.852921470861;14755.483558075415;11279.210455268134;11700.531978720841;11713.414329283502;11715.824262636068;11806.291622502591;3585.3367127081315;3634.3639863024127;3649.3248748981523;3731.2350968051483;3860.073582340246;97273;98068;99197.5040124802;99429;100088.49955750248;10936.398498082523;11079.335239885633;11106;11210.495527701272;11629.24409913353;22892.88553557255;23062.42343941415;23237.419064523183;23578.231632627623;23692.763072369402;7503.812404689817;7528.322450979438;7616.124145723202;7626.656800443993;7630.580318082448;4133.359329303963;4203.684723645739;4249.5113061997645;4269.295566231537;4279.40088387626;3531.5762108547137;3560.0565850049757;3588.3899737044767;3603.963960360415;3629.328574213779;638.1193952345826;651.9706613202417;658.7891874600177;658.8352911772057;665.8701553197177;605.2978544887909;627.6798832595318;628.3810446709987;632.5256057956533;655.1109606634718;9573.808523829484;9951.651692190739;10058.949705251427;10265.12746416548;10285.43430111351;596.4184919703255;654.3195077119742;672.0323527079503;673.4780545077604;677.7661706711177;4701.929471057869;4898.485659005753;4921.384826896638;4927.187014142698;4944.728039957765;91671.54164229135;92529;92574.07425925789;98239.01760982441;112661;94575;94768.63078423095;96379;97946.51026744963;100076.49885251727;64212;67323.99014014794;84814;85508.14491855002;85756;9468.195203407511;9505.809883802423;9525.285603579621;9572;9590.328676992543;48142.79643008813;52534;53069;53423.19865202103;54165.45834541604;61590.84432044857;66243.66878165578;66588;67131;67278.66360668166;10867.782644346911;10891;10902.56389744433;10935.453227338443;11339.036181924628;12142.271463712206;12195;12215.26708397499;12331.383430828602;12389.318587477776;10079.395236285847;11547.307161570332;11570.768584628091;11875.524979000744;12311.876881231074;10475.266731329039;11168.66494005181;11555.537778488766;11896.167268291483;12210.511579536718;11232.887671123184;11768.529258829893;11782.175247732577;11794.76410471803;11901.940490297493;9603.711888643353;9681.322307438693;9746.171575416169;9782.119609235204;10098.949505252427;9322.95338523303;9334.346595738232;9404.529773511435;9507.904920950701;9554.808903822024 02:52:03 INFO - PROCESS | 2019 | __end_tp_report 02:52:03 INFO - PROCESS | 2019 | __start_cc_report 02:52:03 INFO - PROCESS | 2019 | _x_x_mozilla_cycle_collect,389 02:52:03 INFO - PROCESS | 2019 | __end_cc_report 02:52:03 INFO - PROCESS | 2019 | __startTimestamp1487933523702__endTimestamp 02:52:03 INFO - PROCESS | 2019 | 02:52:03 INFO - PROCESS | 2019 | ------- Summary: start ------- 02:52:03 INFO - PROCESS | 2019 | Number of tests: 6 02:52:03 INFO - PROCESS | 2019 | 02:52:03 INFO - PROCESS | 2019 | [#0] dojo.html Cycles:165 Average:5771.94 Median:5981.00 stddev:665.93 (11.1%) stddev-sans-first:631.00 02:52:03 INFO - PROCESS | 2019 | Values: 2982.7 3017.8 3054.8 3374.0 3393.2 5677.6 5712.4 5713.4 5737.9 5742.5 4815.6 5723.7 5760.7 5808.5 5815.5 5237.1 5262.6 5331.8 5332.7 5342.8 5353.6 5363.4 5366.1 5385.4 5387.1 5182.1 5214.3 5346.4 5356.4 5367.5 5250.7 5252.6 5267.6 5313.1 5351.8 5144.8 5229.0 5237.7 5242.9 5346.1 5534.5 5687.1 5765.9 5851.3 5858.0 6144.3 6176.3 6178.5 6246.3 6348.8 6288.2 6312.1 6320.9 6323.5 6361.6 5884.2 5914.1 5920.3 5920.8 5946.0 6233.2 6261.9 6276.3 6280.6 6286.9 6175.4 6184.7 6209.8 6222.7 6224.5 6300.1 6307.9 6310.6 6319.1 6323.5 6131.4 6164.9 6209.6 6218.4 6222.3 5521.5 6285.2 6304.7 6317.8 6317.8 5006.7 5021.1 5029.6 5045.1 5046.9 4359.4 4409.8 4435.6 4505.4 4518.0 5768.5 5807.9 5846.9 5874.8 5935.1 6279.3 6279.3 6282.7 6288.7 6325.8 5640.0 5675.8 5701.1 5716.7 5753.5 5456.7 5463.2 5474.2 5478.5 5481.9 6326.7 6330.3 6333.6 6340.1 6351.1 6156.7 6195.4 6197.0 6265.6 6284.7 6326.9 6352.7 6353.1 6356.1 6364.2 5554.9 6092.6 6206.7 6254.0 6256.2 6096.4 6162.0 6236.6 6305.5 6382.1 4840.6 6139.6 6229.1 6236.2 6252.3 5588.0 6173.6 6201.7 6237.0 6240.0 5867.7 5926.7 5967.4 6035.2 6122.2 6133.3 6134.8 6140.1 6187.5 6201.1 5981.0 6013.0 6041.4 6045.2 6056.8 02:52:03 INFO - PROCESS | 2019 | 02:52:03 INFO - PROCESS | 2019 | [#1] ext.html Cycles:180 Average:52916.02 Median:187990.07 stddev:93322.63 (49.6%) stddev-sans-first:93501.25 02:52:03 INFO - PROCESS | 2019 | Values: 440.4 495.8 498.8 512.6 534.6 39276.8 42500.0 42507.0 42536.0 42569.0 42395.9 43009.6 43074.0 43160.0 43206.8 8459.5 9172.9 9405.9 9435.5 9437.0 8446.2 11368.6 11613.2 11649.4 11834.8 11642.6 11681.1 11717.4 11734.3 11738.0 11634.0 11674.7 11715.1 11716.8 11736.6 11546.5 11627.4 11639.0 11643.2 11651.3 41527.8 41639.0 41792.6 41902.6 41911.8 3391.5 3953.8 3960.7 3970.7 3990.3 30248.7 31344.4 31368.0 32055.0 32069.0 3205.5 3220.5 3231.7 3231.8 3260.1 337736.0 338279.0 338944.3 339558.0 341672.0 68675.7 68940.0 69211.3 69231.0 69543.7 72005.6 72254.0 72400.6 72481.0 72829.9 16775.0 17412.2 17450.5 17453.6 17495.3 11704.5 12238.9 12896.2 13130.2 13210.3 18799.5 19386.3 19402.6 19503.0 19552.8 6764.5 7034.8 7105.8 7110.3 7135.2 721.7 856.7 861.4 872.2 883.1 29780.4 30128.8 30490.8 31134.5 31569.0 937.3 1037.4 1066.1 1068.6 1165.6 13879.2 14434.1 14448.5 15427.4 16402.4 391987.0 394890.0 396882.0 397468.0 397750.0 57983.4 58405.0 58436.0 58561.0 58623.0 1403.0 1434.1 1439.9 1458.7 1461.6 29428.0 30150.8 30212.7 30583.4 30712.9 49694.0 49763.0 50171.0 50186.5 50296.0 315833.0 316263.0 316978.0 317512.0 363442.0 25552.5 26383.2 26421.9 38999.2 39449.8 42634.4 42811.0 44369.6 44528.3 44717.3 34308.1 35406.6 35693.8 36220.6 36420.0 35583.8 36152.8 36335.6 36366.6 36589.1 34816.0 34993.5 35115.6 35512.3 35776.8 29782.0 30222.8 32260.2 33009.7 33305.0 19435.6 24767.0 24820.3 25070.4 25239.9 02:52:03 INFO - PROCESS | 2019 | 02:52:03 INFO - PROCESS | 2019 | [#2] jquery.html Cycles:180 Average:37959.16 Median:21233.44 stddev:109681.94 (516.6%) stddev-sans-first:109953.20 02:52:03 INFO - PROCESS | 2019 | Values: 309.9 352.1 400.0 400.5 408.1 17181.5 19768.5 20043.3 20157.6 20936.1 17879.0 20277.3 20303.4 20798.5 20886.7 4272.4 5008.3 5496.8 5499.0 5503.5 6010.6 6181.3 6205.3 6206.9 6211.3 5183.8 5697.2 5996.5 6093.8 6167.6 5027.4 5972.6 6008.3 6053.3 6062.4 5072.0 5103.7 5750.9 5870.1 6041.2 21925.9 22095.2 24452.5 25585.2 25808.6 2493.4 2599.2 2626.8 2629.9 2645.3 9923.5 10386.3 10394.3 11494.3 14507.5 1768.6 1818.3 1835.5 1849.0 1856.1 103045.0 127377.0 131891.0 146452.0 158349.0 11580.9 11637.7 11903.8 11921.0 12109.2 15884.9 16040.1 16050.4 16075.4 16100.3 8715.8 8882.5 8894.7 8956.5 8979.0 8617.0 8634.2 8660.7 8751.5 8791.6 4858.7 4877.8 4888.3 4892.2 4951.6 2031.6 2063.3 2069.4 2073.8 2074.9 942.8 992.8 1006.3 1044.9 1066.8 17086.4 21462.7 22057.2 22125.6 22302.9 930.5 1062.1 1091.2 1098.2 1099.8 10967.6 11627.7 11630.5 11696.7 11701.0 428214.0 535402.0 665401.7 765792.0 786642.0 151943.0 155923.7 159622.0 168362.0 169978.0 1057.0 1064.9 1102.1 1111.5 1112.1 20228.4 20359.9 20915.7 20953.5 21004.2 49221.0 54222.2 56184.7 59580.2 59737.4 83969.0 86627.1 87353.6 87783.1 88275.6 8510.6 8546.0 8546.1 8799.0 8818.2 12208.5 12619.4 13496.0 13555.7 13787.9 11102.6 11228.7 11343.8 11422.5 11676.0 11608.0 11624.1 11733.4 11932.8 12019.3 11598.7 11853.9 11902.3 11952.5 12051.6 8460.9 8467.5 8484.9 8571.9 8805.9 8389.6 10065.6 11341.9 11664.1 11744.1 02:52:03 INFO - PROCESS | 2019 | 02:52:03 INFO - PROCESS | 2019 | [#3] mootools.html Cycles:180 Average:5441.78 Median:5066.33 stddev:2977.20 (58.8%) stddev-sans-first:2970.13 02:52:03 INFO - PROCESS | 2019 | Values: 1409.2 1409.6 1422.5 1437.5 1437.5 7545.8 7785.5 8041.6 8483.9 8490.9 6958.5 7799.1 8045.5 8107.2 8219.3 2301.6 2350.2 2352.4 2353.3 2358.3 1746.2 2063.8 2326.7 2364.4 2375.6 2249.0 2329.2 2330.1 2340.3 2347.4 2324.2 2335.4 2344.3 2353.0 2354.6 2318.8 2320.8 2383.6 2384.8 2387.0 8402.5 8450.1 8470.3 8475.8 8480.2 4996.8 5148.9 5149.4 5149.8 5152.5 3221.6 3394.7 3458.6 3494.1 3541.6 1175.4 1191.8 1227.0 1243.7 1260.0 8786.2 10843.6 11003.4 11014.6 11017.4 3403.0 4305.6 4696.8 4719.1 4756.8 9132.9 9571.8 9617.4 9620.1 9627.1 4810.5 4847.0 5165.5 5237.1 5251.1 4539.7 4752.5 4786.1 4795.7 4853.7 3856.3 3889.3 3936.8 3985.4 4008.4 1183.6 1224.5 1236.5 1259.8 1266.8 855.4 866.9 870.9 884.7 894.3 5715.8 5728.0 5759.1 5766.3 5998.6 847.7 966.7 979.2 985.4 1015.4 3745.5 3780.5 3802.5 3872.1 3876.0 9898.5 10254.3 10259.1 10260.2 10261.3 10210.6 10212.4 10218.4 10229.8 10238.9 7642.3 7931.7 7951.0 7954.2 7989.8 5620.9 5668.1 5705.1 5762.5 5763.1 8625.0 9242.0 9296.3 9299.5 9392.3 9120.3 9354.8 9430.6 9495.0 9580.6 7110.1 7275.6 7419.8 7423.6 7428.1 7954.2 8039.5 8085.7 8114.4 8132.4 7197.2 7265.7 7335.8 7336.6 7393.0 5734.3 7097.5 7126.2 7141.7 7164.5 5390.4 6168.9 6291.1 6361.0 6453.4 4309.3 4906.1 4942.6 4995.8 5065.5 4372.0 4922.0 4998.0 5046.9 5067.1 02:52:03 INFO - PROCESS | 2019 | 02:52:03 INFO - PROCESS | 2019 | [#4] prototype.html Cycles:180 Average:4572.34 Median:5041.54 stddev:1420.15 (28.2%) stddev-sans-first:1388.35 02:52:03 INFO - PROCESS | 2019 | Values: 351.6 356.6 362.3 366.1 368.3 4552.9 4721.4 4938.9 5214.7 5372.1 4548.3 4751.8 4863.8 5420.2 5456.5 3993.7 4120.1 4123.3 4309.7 4314.7 3888.1 4109.2 4120.3 4121.0 4129.3 3493.2 4052.9 4098.4 4129.0 4147.6 3905.7 4101.9 4110.4 4134.4 4139.1 3404.6 3475.1 3499.8 3522.4 3545.8 4058.0 4808.8 5076.1 5224.7 5287.2 4231.6 4422.9 4686.7 4706.0 4727.3 4564.6 5358.2 5691.9 5748.2 5780.9 3377.5 3831.9 3942.5 3971.9 3983.4 5083.9 6041.1 6051.9 6086.5 6100.4 3429.8 3526.9 3601.8 3825.5 3950.8 3787.7 3898.4 4053.9 4061.2 4088.9 4034.4 4734.1 4747.3 4788.6 4793.0 4902.4 5003.7 5569.9 5725.7 5801.2 1076.9 1311.8 1313.2 1323.5 1326.8 840.4 876.3 887.2 897.5 906.2 4413.0 4470.8 4507.6 5111.4 5168.9 4937.4 5654.7 5758.3 5770.7 5784.7 4382.4 4814.5 4965.2 5186.3 5194.7 2425.4 2707.4 2770.6 2851.5 2962.6 5435.8 5591.7 5757.9 5929.8 5964.6 5473.7 5802.0 5882.8 5896.1 5937.8 5901.3 5922.6 5941.4 5968.6 5971.2 5639.9 5657.9 5678.6 5709.7 5723.6 4752.8 4964.2 5149.5 5479.9 5968.5 6039.5 6243.8 6251.8 6252.7 6265.8 3744.5 3973.7 3997.5 4003.3 4029.5 5348.7 5637.1 5853.5 5899.4 5974.2 5105.5 5661.6 5788.0 5798.9 5836.7 5007.0 5216.3 5325.5 5755.3 5843.3 5268.6 5624.6 5626.8 5636.9 5664.3 5201.5 5343.5 5688.9 5796.9 5810.5 5472.1 5494.0 5649.7 5660.0 5724.7 02:52:03 INFO - PROCESS | 2019 | 02:52:03 INFO - PROCESS | 2019 | [#5] yui.html Cycles:180 Average:20033.78 Median:53794.33 stddev:29081.69 (54.1%) stddev-sans-first:29127.17 02:52:03 INFO - PROCESS | 2019 | Values: 734.4 735.8 751.4 814.5 825.6 14446.0 14867.9 15303.5 15339.4 15343.0 14043.0 14124.8 14245.1 14303.0 14376.1 857.3 868.6 870.0 870.6 871.9 682.3 699.7 848.8 869.6 876.3 905.3 920.7 924.0 924.6 931.5 767.9 919.5 921.1 921.7 922.4 682.0 682.0 682.2 682.7 684.0 14974.8 14975.8 15004.5 15053.2 15343.2 14288.8 14658.9 14661.9 14707.9 14755.5 11279.2 11700.5 11713.4 11715.8 11806.3 3585.3 3634.4 3649.3 3731.2 3860.1 97273.0 98068.0 99197.5 99429.0 100088.5 10936.4 11079.3 11106.0 11210.5 11629.2 22892.9 23062.4 23237.4 23578.2 23692.8 7503.8 7528.3 7616.1 7626.7 7630.6 4133.4 4203.7 4249.5 4269.3 4279.4 3531.6 3560.1 3588.4 3604.0 3629.3 638.1 652.0 658.8 658.8 665.9 605.3 627.7 628.4 632.5 655.1 9573.8 9951.7 10058.9 10265.1 10285.4 596.4 654.3 672.0 673.5 677.8 4701.9 4898.5 4921.4 4927.2 4944.7 91671.5 92529.0 92574.1 98239.0 112661.0 94575.0 94768.6 96379.0 97946.5 100076.5 64212.0 67324.0 84814.0 85508.1 85756.0 9468.2 9505.8 9525.3 9572.0 9590.3 48142.8 52534.0 53069.0 53423.2 54165.5 61590.8 66243.7 66588.0 67131.0 67278.7 10867.8 10891.0 10902.6 10935.5 11339.0 12142.3 12195.0 12215.3 12331.4 12389.3 10079.4 11547.3 11570.8 11875.5 12311.9 10475.3 11168.7 11555.5 11896.2 12210.5 11232.9 11768.5 11782.2 11794.8 11901.9 9603.7 9681.3 9746.2 9782.1 10098.9 9323.0 9334.3 9404.5 9507.9 9554.8 02:52:03 INFO - PROCESS | 2019 | -------- Summary: end -------- 02:52:03 INFO - PROCESS | 2019 | 02:52:04 INFO - TEST-INFO | 2019: exit 0 02:52:04 INFO - TEST-OK | dromaeo_css | took 1115080ms 02:52:04 INFO - TEST-START | kraken 02:52:04 INFO - operating with platform_type : mac_ 02:52:04 INFO - Initialising browser for kraken test... 02:52:04 INFO - TEST-INFO | started process 2025 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/tmpNWkEr6/profile http://localhost:52849/getInfo.html) 02:52:07 INFO - PROCESS | 2025 | 2017-02-24 02:52:07.235 plugin-container[2027:25996] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8943, name = 'com.apple.tsm.portname' 02:52:07 INFO - PROCESS | 2025 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:52:07 INFO - PROCESS | 2025 | 2017-02-24 02:52:07.235 plugin-container[2027:25996] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c1b, name = 'com.apple.CFPasteboardClient' 02:52:07 INFO - PROCESS | 2025 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:52:07 INFO - PROCESS | 2025 | 2017-02-24 02:52:07.235 plugin-container[2027:25996] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:52:07 INFO - PROCESS | 2025 | __metrics Screen width/height:1600/1200 02:52:07 INFO - PROCESS | 2025 | colorDepth:24 02:52:07 INFO - PROCESS | 2025 | Browser inner width/height: 1024/689 02:52:07 INFO - PROCESS | 2025 | __metrics 02:52:07 ERROR - PROCESS | 2025 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 02:52:08 INFO - TEST-INFO | 2025: exit 0 02:52:08 INFO - Browser initialized. 02:52:08 INFO - Running cycle 1/1 for kraken test... 02:52:08 INFO - TEST-INFO | started process 2028 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/tmpNWkEr6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:52:10 INFO - PROCESS | 2028 | 2017-02-24 02:52:10.502 plugin-container[2029:26119] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4743, name = 'com.apple.tsm.portname' 02:52:10 INFO - PROCESS | 2028 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:52:10 INFO - PROCESS | 2028 | 2017-02-24 02:52:10.503 plugin-container[2029:26119] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 02:52:10 INFO - PROCESS | 2028 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:52:10 INFO - PROCESS | 2028 | 2017-02-24 02:52:10.503 plugin-container[2029:26119] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:52:20 INFO - PROCESS | 2028 | RSS: Main: 219238400 02:52:20 INFO - PROCESS | 2028 | 02:52:23 INFO - PROCESS | 2028 | Cycle 1(1): loaded http://localhost:52849/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52849/tests/kraken/driver.html?testName=audio-beat-detection) 02:52:24 INFO - PROCESS | 2028 | RSS: Main: 233406464 02:52:24 INFO - PROCESS | 2028 | 02:52:26 INFO - PROCESS | 2028 | Cycle 1(1): loaded http://localhost:52849/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52849/tests/kraken/driver.html?testName=audio-dft) 02:52:27 INFO - PROCESS | 2028 | RSS: Main: 241090560 02:52:27 INFO - PROCESS | 2028 | 02:52:30 INFO - PROCESS | 2028 | Cycle 1(1): loaded http://localhost:52849/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52849/tests/kraken/driver.html?testName=audio-fft) 02:52:31 INFO - PROCESS | 2028 | RSS: Main: 245030912 02:52:31 INFO - PROCESS | 2028 | 02:52:33 INFO - PROCESS | 2028 | Cycle 1(1): loaded http://localhost:52849/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52849/tests/kraken/driver.html?testName=audio-oscillator) 02:52:34 INFO - PROCESS | 2028 | RSS: Main: 245223424 02:52:34 INFO - PROCESS | 2028 | 02:52:35 INFO - PROCESS | 2028 | Cycle 1(1): loaded http://localhost:52849/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52849/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:52:36 INFO - PROCESS | 2028 | RSS: Main: 246644736 02:52:36 INFO - PROCESS | 2028 | 02:52:39 INFO - PROCESS | 2028 | Cycle 1(1): loaded http://localhost:52849/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52849/tests/kraken/driver.html?testName=imaging-darkroom) 02:52:40 INFO - PROCESS | 2028 | RSS: Main: 250613760 02:52:40 INFO - PROCESS | 2028 | 02:52:43 INFO - PROCESS | 2028 | Cycle 1(1): loaded http://localhost:52849/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52849/tests/kraken/driver.html?testName=imaging-desaturate) 02:52:43 INFO - PROCESS | 2028 | RSS: Main: 250150912 02:52:43 INFO - PROCESS | 2028 | 02:52:46 INFO - PROCESS | 2028 | Cycle 1(1): loaded http://localhost:52849/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52849/tests/kraken/driver.html?testName=json-parse-financial) 02:52:47 INFO - PROCESS | 2028 | RSS: Main: 249847808 02:52:47 INFO - PROCESS | 2028 | 02:52:49 INFO - PROCESS | 2028 | Cycle 1(1): loaded http://localhost:52849/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52849/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:52:49 INFO - PROCESS | 2028 | RSS: Main: 249077760 02:52:49 INFO - PROCESS | 2028 | 02:52:51 INFO - PROCESS | 2028 | Cycle 1(1): loaded http://localhost:52849/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52849/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:52:52 INFO - PROCESS | 2028 | RSS: Main: 249180160 02:52:52 INFO - PROCESS | 2028 | 02:52:54 INFO - PROCESS | 2028 | Cycle 1(1): loaded http://localhost:52849/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52849/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:52:55 INFO - PROCESS | 2028 | RSS: Main: 249147392 02:52:55 INFO - PROCESS | 2028 | 02:52:58 INFO - PROCESS | 2028 | Cycle 1(1): loaded http://localhost:52849/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52849/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:52:58 INFO - PROCESS | 2028 | RSS: Main: 249610240 02:52:58 INFO - PROCESS | 2028 | 02:53:01 INFO - PROCESS | 2028 | Cycle 1(1): loaded http://localhost:52849/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52849/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:53:02 INFO - PROCESS | 2028 | RSS: Main: 249573376 02:53:02 INFO - PROCESS | 2028 | 02:53:04 INFO - PROCESS | 2028 | Cycle 1(1): loaded http://localhost:52849/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52849/tests/kraken/driver.html?testName=ai-astar) 02:53:04 INFO - PROCESS | 2028 | RSS: Main: 251187200 02:53:04 INFO - PROCESS | 2028 | 02:53:04 INFO - PROCESS | 2028 | __start_tp_report 02:53:04 INFO - PROCESS | 2028 | _x_x_mozilla_page_load 02:53:04 INFO - PROCESS | 2028 | _x_x_mozilla_page_load_details 02:53:04 INFO - PROCESS | 2028 | |i|pagename|runs| 02:53:04 INFO - PROCESS | 2028 | |0;ai-astar;106;119;124;179;155;119;115;119;120;119 02:53:04 INFO - PROCESS | 2028 | |1;audio-beat-detection;145;110;111;150;111;113;115;113;132;114 02:53:04 INFO - PROCESS | 2028 | |2;audio-dft;194;228;278;199;195;201;197;200;194;219 02:53:04 INFO - PROCESS | 2028 | |3;audio-fft;84;59;60;87;61;59;59;74;99;51 02:53:04 INFO - PROCESS | 2028 | |4;audio-oscillator;83;70;85;72;70;71;83;70;74;82 02:53:04 INFO - PROCESS | 2028 | |5;imaging-gaussian-blur;124;88;91;90;91;89;91;90;92;90 02:53:04 INFO - PROCESS | 2028 | |6;imaging-darkroom;104;103;103;168;102;104;129;176;106;102 02:53:04 INFO - PROCESS | 2028 | |7;imaging-desaturate;91;92;106;147;119;92;95;91;92;99 02:53:04 INFO - PROCESS | 2028 | |8;json-parse-financial;62;59;61;64;64;64;62;64;62;67 02:53:04 INFO - PROCESS | 2028 | |9;json-stringify-tinderbox;65;74;69;76;77;68;74;87;64;90 02:53:04 INFO - PROCESS | 2028 | |10;stanford-crypto-aes;87;86;81;84;83;87;88;90;105;105 02:53:04 INFO - PROCESS | 2028 | |11;stanford-crypto-ccm;146;136;187;157;130;178;162;163;205;143 02:53:04 INFO - PROCESS | 2028 | |12;stanford-crypto-pbkdf2;227;177;175;170;170;172;170;169;179;170 02:53:04 INFO - PROCESS | 2028 | |13;stanford-crypto-sha256-iterative;68;65;68;65;88;70;62;71;74;91 02:53:04 INFO - PROCESS | 2028 | __end_tp_report 02:53:04 INFO - PROCESS | 2028 | __start_cc_report 02:53:04 INFO - PROCESS | 2028 | _x_x_mozilla_cycle_collect,968 02:53:04 INFO - PROCESS | 2028 | __end_cc_report 02:53:04 INFO - PROCESS | 2028 | __startTimestamp1487933584556__endTimestamp 02:53:04 INFO - PROCESS | 2028 | 02:53:04 INFO - PROCESS | 2028 | ------- Summary: start ------- 02:53:04 INFO - PROCESS | 2028 | Number of tests: 14 02:53:04 INFO - PROCESS | 2028 | 02:53:04 INFO - PROCESS | 2028 | [#0] ai-astar Cycles:10 Average:127.50 Median:119.50 stddev:22.07 (18.5%) stddev-sans-first:22.00 02:53:04 INFO - PROCESS | 2028 | Values: 106.0 119.0 124.0 179.0 155.0 119.0 115.0 119.0 120.0 119.0 02:53:04 INFO - PROCESS | 2028 | 02:53:04 INFO - PROCESS | 2028 | [#1] audio-beat-detection Cycles:10 Average:121.40 Median:114.50 stddev:15.17 (13.2%) stddev-sans-first:13.47 02:53:04 INFO - PROCESS | 2028 | Values: 145.0 110.0 111.0 150.0 111.0 113.0 115.0 113.0 132.0 114.0 02:53:04 INFO - PROCESS | 2028 | 02:53:04 INFO - PROCESS | 2028 | [#2] audio-dft Cycles:10 Average:210.50 Median:200.50 stddev:26.32 (13.1%) stddev-sans-first:27.23 02:53:04 INFO - PROCESS | 2028 | Values: 194.0 228.0 278.0 199.0 195.0 201.0 197.0 200.0 194.0 219.0 02:53:04 INFO - PROCESS | 2028 | 02:53:04 INFO - PROCESS | 2028 | [#3] audio-fft Cycles:10 Average:69.30 Median:67.50 stddev:15.78 (23.4%) stddev-sans-first:15.82 02:53:04 INFO - PROCESS | 2028 | Values: 84.0 59.0 60.0 87.0 61.0 59.0 59.0 74.0 99.0 51.0 02:53:04 INFO - PROCESS | 2028 | 02:53:04 INFO - PROCESS | 2028 | [#4] audio-oscillator Cycles:10 Average:76.00 Median:78.00 stddev:6.39 (8.2%) stddev-sans-first:6.26 02:53:04 INFO - PROCESS | 2028 | Values: 83.0 70.0 85.0 72.0 70.0 71.0 83.0 70.0 74.0 82.0 02:53:04 INFO - PROCESS | 2028 | 02:53:04 INFO - PROCESS | 2028 | [#5] imaging-gaussian-blur Cycles:10 Average:93.60 Median:90.50 stddev:10.74 (11.9%) stddev-sans-first:1.20 02:53:04 INFO - PROCESS | 2028 | Values: 124.0 88.0 91.0 90.0 91.0 89.0 91.0 90.0 92.0 90.0 02:53:04 INFO - PROCESS | 2028 | 02:53:04 INFO - PROCESS | 2028 | [#6] imaging-darkroom Cycles:10 Average:119.70 Median:105.00 stddev:28.78 (27.4%) stddev-sans-first:29.96 02:53:04 INFO - PROCESS | 2028 | Values: 104.0 103.0 103.0 168.0 102.0 104.0 129.0 176.0 106.0 102.0 02:53:04 INFO - PROCESS | 2028 | 02:53:04 INFO - PROCESS | 2028 | [#7] imaging-desaturate Cycles:10 Average:102.40 Median:92.00 stddev:18.04 (19.6%) stddev-sans-first:18.65 02:53:04 INFO - PROCESS | 2028 | Values: 91.0 92.0 106.0 147.0 119.0 92.0 95.0 91.0 92.0 99.0 02:53:04 INFO - PROCESS | 2028 | 02:53:04 INFO - PROCESS | 2028 | [#8] json-parse-financial Cycles:10 Average:62.90 Median:64.00 stddev:2.18 (3.4%) stddev-sans-first:2.29 02:53:04 INFO - PROCESS | 2028 | Values: 62.0 59.0 61.0 64.0 64.0 64.0 62.0 64.0 62.0 67.0 02:53:04 INFO - PROCESS | 2028 | 02:53:04 INFO - PROCESS | 2028 | [#9] json-stringify-tinderbox Cycles:10 Average:74.40 Median:75.00 stddev:8.68 (11.6%) stddev-sans-first:8.52 02:53:04 INFO - PROCESS | 2028 | Values: 65.0 74.0 69.0 76.0 77.0 68.0 74.0 87.0 64.0 90.0 02:53:04 INFO - PROCESS | 2028 | 02:53:04 INFO - PROCESS | 2028 | [#10] stanford-crypto-aes Cycles:10 Average:89.60 Median:86.50 stddev:8.51 (9.8%) stddev-sans-first:8.98 02:53:04 INFO - PROCESS | 2028 | Values: 87.0 86.0 81.0 84.0 83.0 87.0 88.0 90.0 105.0 105.0 02:53:04 INFO - PROCESS | 2028 | 02:53:04 INFO - PROCESS | 2028 | [#11] stanford-crypto-ccm Cycles:10 Average:160.70 Median:162.50 stddev:23.70 (14.6%) stddev-sans-first:24.54 02:53:04 INFO - PROCESS | 2028 | Values: 146.0 136.0 187.0 157.0 130.0 178.0 162.0 163.0 205.0 143.0 02:53:04 INFO - PROCESS | 2028 | 02:53:04 INFO - PROCESS | 2028 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.90 Median:173.50 stddev:17.59 (10.1%) stddev-sans-first:3.64 02:53:04 INFO - PROCESS | 2028 | Values: 227.0 177.0 175.0 170.0 170.0 172.0 170.0 169.0 179.0 170.0 02:53:04 INFO - PROCESS | 2028 | 02:53:04 INFO - PROCESS | 2028 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.20 Median:70.50 stddev:9.75 (13.8%) stddev-sans-first:10.22 02:53:04 INFO - PROCESS | 2028 | Values: 68.0 65.0 68.0 65.0 88.0 70.0 62.0 71.0 74.0 91.0 02:53:04 INFO - PROCESS | 2028 | -------- Summary: end -------- 02:53:04 INFO - PROCESS | 2028 | 02:53:05 INFO - TEST-INFO | 2028: exit 0 02:53:05 INFO - TEST-OK | kraken | took 61060ms 02:53:05 INFO - SUITE-END | took 1176s 02:53:05 INFO - Completed test suite (00:19:36) 02:53:05 INFO - javascript benchmark 02:53:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7289.92183695705, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2982.7315541601265, 3017.8340191289476, 3054.755619550436, 3373.9999999999986, 3393.2365217825977, 5677.602567820254, 5712.371639119693, 5713.428657134285, 5737.885242295151, 5742.454466825655, 4815.638827087965, 5723.685197314146, 5760.683162426065, 5808.506276966453, 5815.534757219423, 5237.083510385686, 5262.578993680516, 5331.786728530874, 5332.706701131437, 5342.786288548473, 5353.625246232766, 5363.410024897277, 5366.141417373221, 5385.407605163429, 5387.111126664116, 5182.093133701606, 5214.348206474191, 5346.4118946915805, 5356.38401583819, 5367.516923476886, 5250.737463126848, 5252.579793616502, 5267.578593712494, 5313.149896016619, 5351.812686555952, 5144.819931302386, 5228.980348831979, 5237.659552129099, 5242.9213561796605, 5346.117890548055, 5534.501894829485, 5687.146927960797, 5765.88468230633, 5851.3270973838125, 5858.033424484955, 6144.341027922481, 6176.320604733521, 6178.474829639486, 6246.25044994599, 6348.809535713936, 6288.151099601541, 6312.147860038882, 6320.873582528324, 6323.462505687022, 6361.55469117162, 5884.176215329857, 5914.112883067488, 5920.289565252154, 5920.792772252994, 5945.970270148621, 6233.2208473940755, 6261.9373806262265, 6276.309605943343, 6280.5603607747935, 6286.937130628727, 6175.382461753788, 6184.721687524072, 6209.751609935643, 6222.657753823583, 6224.533160013018, 6300.086487459384, 6307.905381419282, 6310.6213627182515, 6319.115323854664, 6323.462505687068, 6131.437835141539, 6164.876702466016, 6209.627422354673, 6218.440340369389, 6222.3466536013975, 5521.503064724194, 6285.151504546919, 6304.684765761694, 6317.778877739257, 6317.810465686037, 5006.69959802413, 5021.071101846097, 5029.5724863386295, 5045.066662667345, 5046.873828154326, 4359.367891655692, 4409.757463339547, 4435.600795928317, 4505.43682039745, 4517.977410112929, 5768.451997060357, 5807.912881306784, 5846.912296315559, 5874.765009399662, 5935.109733539917, 6279.309275979638, 6279.309275979638, 6282.748690052438, 6288.748450061947, 6325.841853953596, 5639.971800141055, 5675.77296908119, 5701.144828275709, 5716.685582293014, 5753.453421924911, 5456.672599644034, 5463.2078348639225, 5474.206240095164, 5478.534324582375, 5481.890362192734, 6326.746930122744, 6330.303666596763, 6333.619982801047, 6340.080688300079, 6351.110844481776, 6156.661383623944, 6195.380461953769, 6196.969015154896, 6265.592736472115, 6284.654344011124, 6326.8734625306315, 6352.714127864349, 6353.078803573549, 6356.078368636614, 6364.204474440695, 5554.861128471821, 6092.603980741238, 6206.689665516797, 6254.0, 6256.217972753406, 6096.420840020191, 6162.044883043135, 6236.594621349598, 6305.464035557029, 6382.106505089384, 4840.588549973291, 6139.570230083851, 6229.096780966644, 6236.18929539157, 6252.312245652884, 5587.966226248157, 6173.629582225081, 6201.689915504297, 6237.033259844731, 6239.96880015597, 5867.73595188209, 5926.733297001731, 5967.389142970838, 6035.18524999137, 6122.173506576733, 6133.304060594526, 6134.8159555213415, 6140.109684095871, 6187.504999599932, 6201.10084037803, 5981.0, 6013.0, 6041.4148578050135, 6045.153678485103, 6056.757729690939], "value": 5727.019427301812, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [440.407651708452, 495.7843338147905, 498.8353843231734, 512.5873671694286, 534.599050711966, 39276.821695349114, 42500.0, 42507.0, 42536.0, 42569.0, 42395.9401014974, 43009.569904300944, 43074.0, 43160.0, 43206.783966080206, 8459.53472559009, 9172.908270917289, 9405.85891211629, 9435.481048542328, 9437.0, 8446.155384461536, 11368.60209892654, 11613.245139065975, 11649.359285239309, 11834.8224776628, 11642.592509262178, 11681.065514758842, 11717.355545444998, 11734.29594224345, 11738.0, 11634.0, 11674.70813229676, 11715.121365897592, 11716.82424763625, 11736.647900562912, 11546.53813847445, 11627.418629068512, 11639.0, 11643.18497705161, 11651.300921944625, 41527.7923610383, 41639.0, 41792.582074179474, 41902.580974190176, 41911.7904410476, 3391.5082313064713, 3953.8290963807576, 3960.722749407543, 3970.66249368804, 3990.3016972029777, 30248.697513024807, 31344.37311253785, 31368.0, 32055.03834884957, 32069.0, 3205.5031470121935, 3220.516922461626, 3231.676832316773, 3231.8384080795868, 3260.10347154532, 337736.0, 338279.0, 338944.3052784745, 339558.0, 341672.0, 68675.65662171657, 68940.0, 69211.3078869215, 69231.0, 69543.65228173826, 72005.6399717998, 72254.0, 72400.63799680967, 72481.0, 72829.90755138677, 16775.0, 17412.21645025977, 17450.47648570545, 17453.563660908578, 17495.30018799234, 11704.531818727155, 12238.877611223774, 12896.161749486253, 13130.212187268795, 13210.339483026002, 18799.530011749815, 19386.321478748458, 19402.611947760965, 19503.024848757505, 19552.804471955384, 6764.458843292525, 7034.80408330585, 7105.75129870452, 7110.253423390573, 7135.179454362711, 721.6577166470361, 856.6873091321747, 861.4357595774777, 872.1540106097076, 883.0904168706243, 29780.40439191204, 30128.84935575352, 30490.847545762128, 31134.532982005287, 31569.0, 937.2970272295778, 1037.3775734559204, 1066.1044722433194, 1068.6497829305029, 1165.5745652836654, 13879.167249965034, 14434.061785983877, 14448.494302699355, 15427.382904683911, 16402.425915093154, 391987.0, 394890.0, 396882.0, 397468.0, 397750.0, 57983.420165797805, 58405.0, 58436.0, 58561.0, 58623.0, 1402.9859701403059, 1434.103685196752, 1439.8632129947848, 1458.6645071633584, 1461.5761429185418, 29427.970021050016, 30150.84924575363, 30212.69787302187, 30583.388332232786, 30712.925047623226, 49694.0, 49763.0, 50170.996580068924, 50186.49813501964, 50295.99408011746, 315833.0, 316263.0, 316978.0, 317512.0, 363442.0, 25552.488950221265, 26383.208503744918, 26421.867890660425, 38999.22001559896, 39449.80275098606, 42634.360484592136, 42811.0, 44369.556304437836, 44528.332075018254, 44717.32924006208, 34308.14229644279, 35406.64593354137, 35693.82153089218, 36220.637793621725, 36420.0, 35583.82208088943, 36152.8192359047, 36335.636643633225, 36366.63633363633, 36589.08527286839, 34816.0, 34993.475097873044, 35115.64884351226, 35512.28975420529, 35776.82111589425, 29782.0, 30222.84888575543, 32260.19349516187, 33009.67961281522, 33305.0, 19435.63665370437, 24767.0, 24820.25539233826, 25070.37324066913, 25239.864206111135], "value": 19661.608088945082, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.92097015261106, 352.088091842129, 399.99800499748125, 400.489376045542, 408.0736727628282, 17181.48455546334, 19768.505787355305, 20043.298484553045, 20157.596848063065, 20936.057877395517, 17879.0, 20277.290294839648, 20303.39089827304, 20798.48003799906, 20886.686699699516, 4272.401863739079, 5008.348914641091, 5496.80761173359, 5499.0, 5503.532199763025, 6010.57925945184, 6181.289151747562, 6205.286392064925, 6206.906896396535, 6211.254649442073, 5183.792648294064, 5697.202391665171, 5996.4902983246475, 6093.756249750005, 6167.62994220346, 5027.421846487664, 5972.552058595601, 6008.3390827009, 6053.303870054956, 6062.393760623946, 5071.974640126813, 5103.693778373272, 5750.913736293959, 5870.09013602888, 6041.24484439445, 21925.903704814697, 22095.226667066574, 24452.51094978108, 25585.23244302674, 25808.612870806952, 2493.4140476987895, 2599.233226198276, 2626.8292560983473, 2629.934251643705, 2645.320221659241, 9923.503824808731, 10386.27296089274, 10394.324368915995, 11494.252873563191, 14507.492237771732, 1768.619746754454, 1818.3453956575622, 1835.5227640813484, 1848.9630207395912, 1856.1368963431935, 103045.0, 127377.0, 131891.0, 146451.99999999892, 158349.0, 11580.88419115798, 11637.650870473899, 11903.821442678367, 11921.046316294676, 12109.152359334763, 15884.92057539705, 16040.11779352147, 16050.438234661964, 16075.437359692589, 16100.275487603087, 8715.825683486295, 8882.511461869659, 8894.73315800527, 8956.507392093497, 8978.955105224431, 8616.956915215384, 8634.179752923463, 8660.740177794676, 8751.474911505331, 8791.604377803014, 4858.732769697701, 4877.780499877443, 4888.340074089952, 4892.217245240744, 4951.579115775127, 2031.628650660798, 2063.329417939176, 2069.368842503051, 2073.8133567978653, 2074.8547601667738, 942.79258563116, 992.8135877626167, 1006.3307900246255, 1044.9164066874632, 1066.8453074304339, 17086.437034444934, 21462.72533224536, 22057.22799702003, 22125.60096754523, 22302.888485557793, 930.4696323095906, 1062.1396668698223, 1091.247039542713, 1098.1983152298867, 1099.8130317845985, 10967.561297548009, 11627.6511704649, 11630.53477860876, 11696.70758231051, 11701.0, 428214.0, 535402.0, 665401.6729916319, 765792.0, 786642.0, 151943.0, 155923.6611450829, 159622.0, 168362.0, 169978.0, 1056.963006294776, 1064.920130990179, 1102.101787043557, 1111.5331560744507, 1112.0936436803818, 20228.393148205578, 20359.898200508902, 20915.686264706346, 20953.476163096046, 21004.159833606485, 49221.0, 54222.18666719923, 56184.719076404355, 59580.19509812278, 59737.40262597492, 83969.0, 86627.13372866191, 87353.56323218343, 87783.12216878004, 88275.55862220647, 8510.553205954879, 8545.957270213858, 8546.102659220693, 8798.9881163667, 8818.206361427503, 12208.511659533518, 12619.432125554189, 13496.0, 13555.728885422433, 13787.896968242316, 11102.555897764, 11228.66314010581, 11343.829842552534, 11422.543098275975, 11676.0, 11608.0, 11624.07007439386, 11733.354665493138, 11932.76134477323, 12019.278843269432, 11598.652040438801, 11853.881461185278, 11902.285862848257, 11952.489977104906, 12051.57819476314, 8460.873086903825, 8467.53428561435, 8484.91515084866, 8571.914280857362, 8805.911940880766, 8389.580520974048, 10065.597376105166, 11341.886581134084, 11664.066874649838, 11744.119191060876], "value": 10019.801637308236, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1409.2037998530836, 1409.6264489910175, 1422.4594654031466, 1437.4825062977327, 1437.4896911596386, 7545.849083018336, 7785.493942893722, 8041.638126284317, 8483.91516084839, 8490.872636910444, 6958.478114141447, 7799.10310314314, 8045.477043992151, 8107.22981316774, 8219.342452603792, 2301.5627030864166, 2350.21267875262, 2352.3883790214495, 2353.329301149173, 2358.3278765551822, 1746.2491128814604, 2063.814256716895, 2326.674265602817, 2364.3970787449175, 2375.5961486547244, 2248.9887550562225, 2329.24299602629, 2330.1029103795076, 2340.3096086654477, 2347.448349637834, 2324.1633012115626, 2335.35777661142, 2344.3201471573225, 2352.9646955339595, 2354.5526349993447, 2318.802901753353, 2320.8491448055993, 2383.642453631952, 2384.7615238476187, 2387.045181927243, 8402.45384050041, 8450.112738162466, 8470.322374210049, 8475.830483390358, 8480.194381533744, 4996.825111121129, 5148.897022059537, 5149.382074151126, 5149.76826042829, 5152.536271735525, 3221.6295126060336, 3394.6605339466105, 3458.6195518492946, 3494.0915362006062, 3541.557305336833, 1175.4357908204024, 1191.845060142176, 1227.0, 1243.6952946528068, 1260.023481801602, 8786.209241168262, 10843.620473283476, 11003.394813285346, 11014.614488492944, 11017.394043327613, 3402.965970340265, 4305.579158877563, 4696.8121275148615, 4719.126961512131, 4756.762161891892, 9132.863007054899, 9571.808563828823, 9617.374870633386, 9620.086091821266, 9627.085426884434, 4810.470848206694, 4846.975765121222, 5165.535101840777, 5237.083510385667, 5251.133562962068, 4539.72761634303, 4752.52474752522, 4786.138495070921, 4795.736234507136, 4853.733044682576, 3856.267309211241, 3889.319369110451, 3936.7637941723588, 3985.4221137935415, 4008.358662614026, 1183.6153250193722, 1224.5285565057518, 1236.4992178167856, 1259.8488181418106, 1266.7529831682918, 855.3713020929612, 866.8743032260413, 870.856308709056, 884.7036242858586, 894.338189739601, 5715.799947001919, 5727.971360143172, 5759.136129580596, 5766.308043034863, 5998.580099393001, 847.6905929335747, 966.7003228998892, 979.2459805949521, 985.3890587835588, 1015.4059874973076, 3745.4569087482164, 3780.4896338994436, 3802.4676545283683, 3872.128771026553, 3875.9806200968815, 9898.455584942898, 10254.333468324536, 10259.127974122282, 10260.179185665129, 10261.28171028021, 10210.591576337012, 10212.438315892548, 10218.386896786216, 10229.795404091876, 10238.897611023795, 7642.312191902755, 7931.722389716332, 7950.960245198737, 7954.164812694699, 7989.76030719091, 5620.9156862647915, 5668.064769313182, 5705.144228365778, 5762.481376676119, 5763.106718458645, 8624.956875215585, 9241.953790231006, 9296.349255552046, 9299.535023248674, 9392.342536022414, 9120.315976301672, 9354.76613084651, 9430.575624096795, 9495.0, 9580.56887440053, 7110.1112360954885, 7275.563466192046, 7419.8145046374275, 7423.5917024562, 7428.071491063617, 7954.164812694584, 8039.5176289422825, 8085.716999904975, 8114.431989760897, 8132.390070744599, 7197.208307086321, 7265.673044712895, 7335.816604584928, 7336.633168341668, 7393.0, 5734.254546908875, 7097.467689923174, 7126.180489243803, 7141.678624462015, 7164.534305270141, 5390.353157621111, 6168.920438923081, 6291.1192433058495, 6361.01404282337, 6453.354664533509, 4309.2674245378985, 4906.092372911023, 4942.604591632733, 4995.8001679932395, 5065.544101030778, 4371.956280437155, 4921.95920322538, 4997.9750101249265, 5046.924296135634, 5067.113255180402], "value": 4422.178272401087, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.6062010548185, 356.58101730466694, 362.33330671564323, 366.05192551292146, 368.3406702003413, 4552.908941821166, 4721.433427988646, 4938.876528086796, 5214.739263036852, 5372.113601255793, 4548.272276435771, 4751.833685820997, 4863.829765958192, 5420.186971954209, 5456.454354564542, 3993.7204395692315, 4120.134771697947, 4123.319652257389, 4309.741415515064, 4314.748722870371, 3888.1446081862086, 4109.239790638741, 4120.320147175712, 4120.979395103021, 4129.256733787917, 3493.1616412061176, 4052.8986775330704, 4098.426220329141, 4128.958710412902, 4147.610550465598, 3905.687544996422, 4101.876943691694, 4110.445089912853, 4134.359174327984, 4139.1100913303635, 3404.570080566168, 3475.113845969287, 3499.8075105869166, 3522.43641017436, 3545.804980726059, 4057.9594204057876, 4808.807647694088, 5076.086304465195, 5224.712640804754, 5287.206918962148, 4231.619154276099, 4422.867313980586, 4686.742229177394, 4706.0, 4727.321800760715, 4564.589186973189, 5358.196270559409, 5691.9146212806845, 5748.19525266463, 5780.855478613026, 3377.5102610121394, 3831.8695984684587, 3942.467766851467, 3971.920561588781, 3983.40248962655, 5083.872903177413, 6041.127250552343, 6051.909221361683, 6086.543509236781, 6100.359462256443, 3429.8456569453933, 3526.889029955556, 3601.837917293728, 3825.4835597194024, 3950.7827069510877, 3787.7348585599293, 3898.3957486589625, 4053.858114966021, 4061.2080644274674, 4088.856890008895, 4034.3545032794614, 4734.147853386424, 4747.314703280285, 4788.640851936118, 4792.95207047932, 4902.362692849907, 5003.674761140514, 5569.944300557024, 5725.656460612377, 5801.187833703285, 1076.9192310576582, 1311.76388250114, 1313.1792629606496, 1323.543377534749, 1326.8009798530297, 840.403313647305, 876.3164731509432, 887.2458410351279, 897.4608546343053, 906.2432868554699, 4413.029133590605, 4470.809303441355, 4507.6168525675685, 5111.412187598399, 5168.870778230575, 4937.432195297515, 5654.717264136777, 5758.337791154071, 5770.711464426762, 5784.652920824764, 4382.408374869352, 4814.470408255089, 4965.187706487179, 5186.325777648957, 5194.662346947512, 2425.4421483058995, 2707.377303220231, 2770.561905523167, 2851.4744611632677, 2962.5704272880744, 5435.809746658848, 5591.692456914909, 5757.940651840442, 5929.762809487658, 5964.642121472725, 5473.698946557977, 5801.970990145022, 5882.823515294548, 5896.056630939029, 5937.832691067815, 5901.262342207224, 5922.585419020627, 5941.376155503696, 5968.612554977956, 5971.178790468949, 5639.915401269066, 5657.886842263049, 5678.592844293391, 5709.743061562157, 5723.599348045597, 4752.786124624331, 4964.230544265644, 5149.459306772735, 5479.945200548103, 5968.522518198621, 6039.456448919618, 6243.750249989949, 6251.78118765841, 6252.749890004349, 6265.843353916189, 3744.4570537271397, 3973.6622387097423, 3997.5003124609425, 4003.299422600975, 4029.49631296088, 5348.732563371738, 5637.098064309691, 5853.502452291603, 5899.410058994066, 5974.1934838796205, 5105.489451054865, 5661.612904838341, 5787.971060144672, 5798.855028624318, 5836.686745482232, 5007.0, 5216.269722238965, 5325.520703136736, 5755.251817263729, 5843.328017277898, 5268.604854635841, 5624.634398764068, 5626.831195064155, 5636.915446268227, 5664.320281566238, 5201.514984960161, 5343.465653434625, 5688.886222275614, 5796.913046304393, 5810.477057064884, 5472.088558677572, 5493.983613031602, 5649.71751412436, 5659.971700141473, 5724.713764311685], "value": 4131.132458423094, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [734.3904559215852, 735.8050116719068, 751.4138971602152, 814.5347886619136, 825.6243409248791, 14446.0, 14867.851321486782, 15303.540893773177, 15339.386424543005, 15343.00270482418, 14043.016988810787, 14124.788128178085, 14245.14529128253, 14303.0, 14376.137431754101, 857.2541888556949, 868.6047848229073, 869.9913000869974, 870.6299822575412, 871.930245580352, 682.3074579301988, 699.7341010416035, 848.8047749017699, 869.6217145541709, 876.2639382918347, 905.2531661379388, 920.7283851263893, 923.9861402078974, 924.5931790012406, 931.4690626342987, 767.9040119985002, 919.4758987377164, 921.1019256225127, 921.6958403726754, 922.4004397141845, 681.9897701534481, 681.993180068198, 682.1779755394787, 682.7132604306204, 684.0184335478555, 14974.775378369333, 14975.775363369557, 15004.474843380429, 15053.247337633074, 15343.156126413043, 14288.785668214985, 14658.926705366512, 14661.853381466262, 14707.852921470861, 14755.483558075415, 11279.210455268134, 11700.531978720841, 11713.414329283502, 11715.824262636068, 11806.291622502591, 3585.3367127081315, 3634.3639863024127, 3649.3248748981523, 3731.2350968051483, 3860.073582340246, 97273.0, 98068.0, 99197.5040124802, 99429.0, 100088.49955750248, 10936.398498082523, 11079.335239885633, 11106.0, 11210.495527701272, 11629.24409913353, 22892.88553557255, 23062.42343941415, 23237.419064523183, 23578.231632627623, 23692.763072369402, 7503.812404689817, 7528.322450979438, 7616.124145723202, 7626.656800443993, 7630.580318082448, 4133.359329303963, 4203.684723645739, 4249.5113061997645, 4269.295566231537, 4279.40088387626, 3531.5762108547137, 3560.0565850049757, 3588.3899737044767, 3603.963960360415, 3629.328574213779, 638.1193952345826, 651.9706613202417, 658.7891874600177, 658.8352911772057, 665.8701553197177, 605.2978544887909, 627.6798832595318, 628.3810446709987, 632.5256057956533, 655.1109606634718, 9573.808523829484, 9951.651692190739, 10058.949705251427, 10265.12746416548, 10285.43430111351, 596.4184919703255, 654.3195077119742, 672.0323527079503, 673.4780545077604, 677.7661706711177, 4701.929471057869, 4898.485659005753, 4921.384826896638, 4927.187014142698, 4944.728039957765, 91671.54164229135, 92529.0, 92574.07425925789, 98239.01760982441, 112661.0, 94575.0, 94768.63078423095, 96379.0, 97946.51026744963, 100076.49885251727, 64212.0, 67323.99014014794, 84814.0, 85508.14491855002, 85756.0, 9468.195203407511, 9505.809883802423, 9525.285603579621, 9572.0, 9590.328676992543, 48142.79643008813, 52534.0, 53069.0, 53423.19865202103, 54165.45834541604, 61590.84432044857, 66243.66878165578, 66588.0, 67131.0, 67278.66360668166, 10867.782644346911, 10891.0, 10902.56389744433, 10935.453227338443, 11339.036181924628, 12142.271463712206, 12195.0, 12215.26708397499, 12331.383430828602, 12389.318587477776, 10079.395236285847, 11547.307161570332, 11570.768584628091, 11875.524979000744, 12311.876881231074, 10475.266731329039, 11168.66494005181, 11555.537778488766, 11896.167268291483, 12210.511579536718, 11232.887671123184, 11768.529258829893, 11782.175247732577, 11794.76410471803, 11901.940490297493, 9603.711888643353, 9681.322307438693, 9746.171575416169, 9782.119609235204, 10098.949505252427, 9322.95338523303, 9334.346595738232, 9404.529773511435, 9507.904920950701, 9554.808903822024], "value": 7280.785894721386, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1558.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 119.0, 124.0, 179.0, 155.0, 119.0, 115.0, 119.0, 120.0, 119.0], "value": 127.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 110.0, 111.0, 150.0, 111.0, 113.0, 115.0, 113.0, 132.0, 114.0], "value": 121.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 228.0, 278.0, 199.0, 195.0, 201.0, 197.0, 200.0, 194.0, 219.0], "value": 210.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 59.0, 60.0, 87.0, 61.0, 59.0, 59.0, 74.0, 99.0, 51.0], "value": 69.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 70.0, 85.0, 72.0, 70.0, 71.0, 83.0, 70.0, 74.0, 82.0], "value": 76.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 88.0, 91.0, 90.0, 91.0, 89.0, 91.0, 90.0, 92.0, 90.0], "value": 93.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 103.0, 103.0, 168.0, 102.0, 104.0, 129.0, 176.0, 106.0, 102.0], "value": 119.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 106.0, 147.0, 119.0, 92.0, 95.0, 91.0, 92.0, 99.0], "value": 102.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 59.0, 61.0, 64.0, 64.0, 64.0, 62.0, 64.0, 62.0, 67.0], "value": 62.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 74.0, 69.0, 76.0, 77.0, 68.0, 74.0, 87.0, 64.0, 90.0], "value": 74.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 81.0, 84.0, 83.0, 87.0, 88.0, 90.0, 105.0, 105.0], "value": 89.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 136.0, 187.0, 157.0, 130.0, 178.0, 162.0, 163.0, 205.0, 143.0], "value": 160.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [227.0, 177.0, 175.0, 170.0, 170.0, 172.0, 170.0, 169.0, 179.0, 170.0], "value": 177.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 65.0, 68.0, 65.0, 88.0, 70.0, 62.0, 71.0, 74.0, 91.0], "value": 72.2, "unit": "score"}]}]} 02:53:05 INFO - Return code: 0 02:53:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:53:05 ERROR - # TBPL SUCCESS # 02:53:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:53:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:53:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:53:05 INFO - 2017-02-24 02:53:05.823 screenresolution[2033:26501] starting screenresolution argv=screenresolution get 02:53:05 INFO - 2017-02-24 02:53:05.826 screenresolution[2033:26501] Display 0: 1600x1200x32@60 02:53:05 INFO - 2017-02-24 02:53:05.832 screenresolution[2034:26504] starting screenresolution argv=screenresolution list 02:53:05 INFO - Available Modes on Display 0 02:53:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:53:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:53:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:53:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:53:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:53:06 INFO - Intel Iris: 02:53:06 INFO - Chipset Model: Intel Iris 02:53:06 INFO - Type: GPU 02:53:06 INFO - Bus: Built-In 02:53:06 INFO - VRAM (Dynamic, Max): 1536 MB 02:53:06 INFO - Vendor: Intel (0x8086) 02:53:06 INFO - Device ID: 0x0a2e 02:53:06 INFO - Revision ID: 0x0009 02:53:06 INFO - Displays: 02:53:06 INFO - Display: 02:53:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:53:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:53:06 INFO - Display Serial Number: 1600x1200 60 02:53:06 INFO - Main Display: Yes 02:53:06 INFO - Mirror: Off 02:53:06 INFO - Online: Yes 02:53:06 INFO - Rotation: Supported 02:53:06 INFO - Return code: 0 02:53:06 INFO - Running post-action listener: _resource_record_post_action 02:53:06 INFO - [mozharness: 2017-02-24 10:53:06.068634Z] Finished run-tests step (success) 02:53:06 INFO - Running post-run listener: _resource_record_post_run 02:53:06 INFO - Total resource usage - Wall time: 1197s; CPU: 54.0%; Read bytes: 2711552; Write bytes: 514033664; Read time: 13; Write time: 1659 02:53:06 INFO - TinderboxPrint: CPU usage
54.2% 02:53:06 INFO - TinderboxPrint: I/O read bytes / time
2,711,552 / 13 02:53:06 INFO - TinderboxPrint: I/O write bytes / time
514,033,664 / 1,659 02:53:06 INFO - TinderboxPrint: CPU idle
2,191.4 (45.8%) 02:53:06 INFO - TinderboxPrint: CPU system
960.8 (20.1%) 02:53:06 INFO - TinderboxPrint: CPU user
1,637.6 (34.2%) 02:53:06 INFO - TinderboxPrint: Swap in / out
210,276,352 / 0 02:53:06 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 203229696; Write bytes: 199237632; Read time: 15695; Write time: 446 02:53:06 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 2711552; Write bytes: 304097280; Read time: 13; Write time: 1175 02:53:06 INFO - Running post-run listener: _upload_blobber_files 02:53:06 INFO - Blob upload gear active. 02:53:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:53:06 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 02:53:06 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:53:06 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:53:06 INFO - (blobuploader) - INFO - Open directory for files ... 02:53:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:53:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:53:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:53:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:53:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:53:08 INFO - (blobuploader) - INFO - Done attempting. 02:53:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:53:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:53:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:53:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:53:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:53:09 INFO - (blobuploader) - INFO - Done attempting. 02:53:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:53:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:53:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:53:10 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:53:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:53:10 INFO - (blobuploader) - INFO - Done attempting. 02:53:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:53:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:53:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:53:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:53:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:53:12 INFO - (blobuploader) - INFO - Done attempting. 02:53:12 INFO - (blobuploader) - INFO - Iteration through files over. 02:53:12 INFO - Return code: 0 02:53:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:53:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:53:12 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/361610dd028014af97d5cf5b5182ccfa6fd455222492586a9129806612ce08d471b0e933d4fd8842cbd17a49c9b26e5ea925b73c4f9ec29bc655227c8c024ef5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/adee2f25068f2e52afebf253e442c7d7fc758dda01059f20f237ef62fb3065ce432b8bd737868b58cd5037644649a2a296a21179b1d8cd39b8941ffa5175ebdf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a935cf9b572949c443e3d773a0efc0acb72d188ef51f3af80431648f299e788050282606a2980f64eb3f7b4daa66045315067501cc49290976512c7e649bf790", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/322b9adbba371e9b4631e447198417bba40d092a21a1c7f230c44a1d90ee31f7aef99e0750827da79fa1d9b84a8d1746ef7f0f2f99624cfc0d3a0b4ff2298948"} 02:53:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:53:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:53:12 INFO - Contents: 02:53:12 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/361610dd028014af97d5cf5b5182ccfa6fd455222492586a9129806612ce08d471b0e933d4fd8842cbd17a49c9b26e5ea925b73c4f9ec29bc655227c8c024ef5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/adee2f25068f2e52afebf253e442c7d7fc758dda01059f20f237ef62fb3065ce432b8bd737868b58cd5037644649a2a296a21179b1d8cd39b8941ffa5175ebdf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a935cf9b572949c443e3d773a0efc0acb72d188ef51f3af80431648f299e788050282606a2980f64eb3f7b4daa66045315067501cc49290976512c7e649bf790", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/322b9adbba371e9b4631e447198417bba40d092a21a1c7f230c44a1d90ee31f7aef99e0750827da79fa1d9b84a8d1746ef7f0f2f99624cfc0d3a0b4ff2298948"} 02:53:12 INFO - Running post-run listener: copy_logs_to_upload_dir 02:53:12 INFO - Copying logs to upload dir... 02:53:12 INFO - mkdir: /builds/slave/test/build/upload/logs 02:53:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.682477 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-02-24 02:53:12.292090) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-24 02:53:12.295493) ========= 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.ezIfkbM4cX/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.iyXwnWOk3i/Listeners TMPDIR=/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/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-Aurora/sha512/361610dd028014af97d5cf5b5182ccfa6fd455222492586a9129806612ce08d471b0e933d4fd8842cbd17a49c9b26e5ea925b73c4f9ec29bc655227c8c024ef5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/adee2f25068f2e52afebf253e442c7d7fc758dda01059f20f237ef62fb3065ce432b8bd737868b58cd5037644649a2a296a21179b1d8cd39b8941ffa5175ebdf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a935cf9b572949c443e3d773a0efc0acb72d188ef51f3af80431648f299e788050282606a2980f64eb3f7b4daa66045315067501cc49290976512c7e649bf790", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/322b9adbba371e9b4631e447198417bba40d092a21a1c7f230c44a1d90ee31f7aef99e0750827da79fa1d9b84a8d1746ef7f0f2f99624cfc0d3a0b4ff2298948"} build_url:https://queue.taskcluster.net/v1/task/CS6MS_A5TtS3pYoG46LpVg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011302 build_url: 'https://queue.taskcluster.net/v1/task/CS6MS_A5TtS3pYoG46LpVg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/361610dd028014af97d5cf5b5182ccfa6fd455222492586a9129806612ce08d471b0e933d4fd8842cbd17a49c9b26e5ea925b73c4f9ec29bc655227c8c024ef5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/adee2f25068f2e52afebf253e442c7d7fc758dda01059f20f237ef62fb3065ce432b8bd737868b58cd5037644649a2a296a21179b1d8cd39b8941ffa5175ebdf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a935cf9b572949c443e3d773a0efc0acb72d188ef51f3af80431648f299e788050282606a2980f64eb3f7b4daa66045315067501cc49290976512c7e649bf790", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/322b9adbba371e9b4631e447198417bba40d092a21a1c7f230c44a1d90ee31f7aef99e0750827da79fa1d9b84a8d1746ef7f0f2f99624cfc0d3a0b4ff2298948"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-24 02:53:12.329471) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-24 02:53:12.329799) ========= 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.ezIfkbM4cX/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.iyXwnWOk3i/Listeners TMPDIR=/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/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.005105 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-24 02:53:12.378321) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-24 02:53:12.378627) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-24 02:53:12.378972) ========= ========= Total master_lag: 0.18 =========