builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0324 starttime: 1486145103.97 results: success (0) buildid: 20170203074109 builduid: f1936783772a420f8c67178e14e80373 revision: cb874e871110d67e78f2c8bc37b618ebb9ba0e4c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-03 10:05:03.971287) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-03 10:05:03.971790) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-03 10:05:03.972118) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-03 10:05:03.998180) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 10:05:03.998550) ========= 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.qivElZA6ZR/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.QWiOqwkFRz/Listeners TMPDIR=/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/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-03 10:05:04-- 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% 96.0M=0s 2017-02-03 10:05:04 (96.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.157768 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 10:05:04.180585) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 10:05:04.180959) ========= 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.qivElZA6ZR/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.QWiOqwkFRz/Listeners TMPDIR=/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/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.030871 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 10:05:04.236664) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-03 10:05:04.237075) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev cb874e871110d67e78f2c8bc37b618ebb9ba0e4c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev cb874e871110d67e78f2c8bc37b618ebb9ba0e4c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.qivElZA6ZR/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.QWiOqwkFRz/Listeners TMPDIR=/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/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-03 10:05:04,345 truncating revision to first 12 chars 2017-02-03 10:05:04,345 Setting DEBUG logging. 2017-02-03 10:05:04,345 attempt 1/10 2017-02-03 10:05:04,345 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/cb874e871110?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-03 10:05:05,128 unpacking tar archive at: mozilla-beta-cb874e871110/testing/mozharness/ program finished with exit code 0 elapsedTime=1.055853 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-03 10:05:05.316818) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-03 10:05:05.317238) ========= script_repo_revision: cb874e871110d67e78f2c8bc37b618ebb9ba0e4c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-03 10:05:05.317721) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-03 10:05:05.318162) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-03 10:05:05.338919) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-02-03 10:05:05.339431) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.qivElZA6ZR/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.QWiOqwkFRz/Listeners TMPDIR=/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/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 10:05:05 INFO - MultiFileLogger online at 20170203 10:05:05 in /builds/slave/test 10:05:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 10:05:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:05:05 INFO - {'append_to_log': False, 10:05:05 INFO - 'base_work_dir': '/builds/slave/test', 10:05:05 INFO - 'blob_upload_branch': 'Mozilla-Beta', 10:05:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:05:05 INFO - 'branch': 'Mozilla-Beta', 10:05:05 INFO - 'buildbot_json_path': 'buildprops.json', 10:05:05 INFO - 'config_files': ('talos/mac_config.py',), 10:05:05 INFO - 'default_actions': ('clobber', 10:05:05 INFO - 'read-buildbot-config', 10:05:05 INFO - 'download-and-extract', 10:05:05 INFO - 'populate-webroot', 10:05:05 INFO - 'create-virtualenv', 10:05:05 INFO - 'install', 10:05:05 INFO - 'run-tests'), 10:05:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:05:05 INFO - 'download_minidump_stackwalk': True, 10:05:05 INFO - 'download_symbols': 'ondemand', 10:05:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:05:05 INFO - 'tooltool.py': '/tools/tooltool.py', 10:05:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:05:05 INFO - '/tools/misc-python/virtualenv.py')}, 10:05:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:05:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:05:05 INFO - 'installer_path': 'installer.exe', 10:05:05 INFO - 'log_level': 'info', 10:05:05 INFO - 'log_name': 'talos', 10:05:05 INFO - 'log_to_console': True, 10:05:05 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:05:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:05:05 INFO - 'opt_config_files': (), 10:05:05 INFO - 'pip_index': False, 10:05:05 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:05:05 INFO - 'cmd': ('bash', 10:05:05 INFO - '-c', 10:05:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:05:05 INFO - 'enabled': True, 10:05:05 INFO - 'halt_on_failure': False, 10:05:05 INFO - 'name': 'check_screen_resolution'},), 10:05:05 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:05:05 INFO - 'cmd': ('bash', 10:05:05 INFO - '-c', 10:05:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:05:05 INFO - 'enabled': True, 10:05:05 INFO - 'halt_on_failure': False, 10:05:05 INFO - 'name': 'check_screen_resolution'},), 10:05:05 INFO - 'run_cmd_checks_enabled': True, 10:05:05 INFO - 'sps_profile': False, 10:05:05 INFO - 'sps_profile_interval': 0, 10:05:05 INFO - 'suite': 'dromaeojs-e10s', 10:05:05 INFO - 'system_bits': '32', 10:05:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:05:05 INFO - 'title': 't-yosemite-r7-0324', 10:05:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:05:05 INFO - 'use_talos_json': True, 10:05:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:05:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:05:05 INFO - 'work_dir': 'build'} 10:05:05 INFO - [mozharness: 2017-02-03 18:05:05.554908Z] Running clobber step. 10:05:05 INFO - Running pre-action listener: _resource_record_pre_action 10:05:05 INFO - Running main action method: clobber 10:05:05 INFO - rmtree: /builds/slave/test/build 10:05:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:05:08 INFO - Running post-action listener: _resource_record_post_action 10:05:08 INFO - [mozharness: 2017-02-03 18:05:08.102730Z] Finished clobber step (success) 10:05:08 INFO - [mozharness: 2017-02-03 18:05:08.102865Z] Running read-buildbot-config step. 10:05:08 INFO - Running pre-action listener: _resource_record_pre_action 10:05:08 INFO - Running main action method: read_buildbot_config 10:05:08 INFO - Using buildbot properties: 10:05:08 INFO - { 10:05:08 INFO - "project": "", 10:05:08 INFO - "product": "firefox", 10:05:08 INFO - "script_repo_revision": "production", 10:05:08 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 10:05:08 INFO - "repository": "", 10:05:08 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 10:05:08 INFO - "buildid": "20170203074109", 10:05:08 INFO - "pgo_build": "False", 10:05:08 INFO - "basedir": "/builds/slave/test", 10:05:08 INFO - "buildnumber": 10, 10:05:08 INFO - "slavename": "t-yosemite-r7-0324", 10:05:08 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 10:05:08 INFO - "platform": "yosemite_r7", 10:05:08 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 10:05:08 INFO - "branch": "mozilla-beta", 10:05:08 INFO - "repo_path": "releases/mozilla-beta", 10:05:08 INFO - "revision": "cb874e871110d67e78f2c8bc37b618ebb9ba0e4c", 10:05:08 INFO - "stage_platform": "macosx64", 10:05:08 INFO - "builduid": "f1936783772a420f8c67178e14e80373", 10:05:08 INFO - "slavebuilddir": "test" 10:05:08 INFO - } 10:05:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/dqyKb6dVTjmf1FK_9gQXYQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 10:05:08 INFO - Running post-action listener: _resource_record_post_action 10:05:08 INFO - [mozharness: 2017-02-03 18:05:08.106245Z] Finished read-buildbot-config step (success) 10:05:08 INFO - [mozharness: 2017-02-03 18:05:08.106334Z] Running download-and-extract step. 10:05:08 INFO - Running pre-action listener: _resource_record_pre_action 10:05:08 INFO - Running main action method: download_and_extract 10:05:08 INFO - mkdir: /builds/slave/test/build/tests 10:05:08 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')]} 10:05:08 INFO - trying https://queue.taskcluster.net/v1/task/dqyKb6dVTjmf1FK_9gQXYQ/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 10:05:08 INFO - Downloading https://queue.taskcluster.net/v1/task/dqyKb6dVTjmf1FK_9gQXYQ/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 10:05:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dqyKb6dVTjmf1FK_9gQXYQ/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json'}, attempt #1 10:05:09 INFO - Downloaded 1165 bytes. 10:05:09 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 10:05:09 INFO - Using the following test package requirements: 10:05:09 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 10:05:09 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 10:05:09 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 10:05:09 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 10:05:09 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 10:05:09 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 10:05:09 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 10:05:09 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 10:05:09 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 10:05:09 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 10:05:09 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 10:05:09 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 10:05:09 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 10:05:09 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 10:05:09 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 10:05:09 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 10:05:09 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 10:05:09 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 10:05:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dqyKb6dVTjmf1FK_9gQXYQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 10:05:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dqyKb6dVTjmf1FK_9gQXYQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 10:05:09 INFO - Fetch https://queue.taskcluster.net/v1/task/dqyKb6dVTjmf1FK_9gQXYQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 10:05:10 INFO - Http code: 200 10:05:10 INFO - via: 1.1 23172d761378a3865feafcda78328053.cloudfront.net (CloudFront) 10:05:10 INFO - x-amz-cf-id: dgkI2XNULPVLpB5wClqyjD1GNiAXuFlfnSRMPtm864FT72MVV2DLVQ== 10:05:10 INFO - x-amz-version-id: m1dnlO.024PRP3MTrohQR6kdFKI7sQjH 10:05:10 INFO - Expected file size: 16092080 10:05:10 INFO - Obtained file size: 16092080 10:05:17 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip', u'firefox-52.0.en-US.mac.talos.tests.zip'] for test suite category: talos 10:05:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dqyKb6dVTjmf1FK_9gQXYQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 10:05:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dqyKb6dVTjmf1FK_9gQXYQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 10:05:17 INFO - Fetch https://queue.taskcluster.net/v1/task/dqyKb6dVTjmf1FK_9gQXYQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 10:05:17 INFO - Http code: 200 10:05:17 INFO - via: 1.1 d8f42fc9558e3e49ebfdf8834baeb756.cloudfront.net (CloudFront) 10:05:17 INFO - x-amz-cf-id: oELzeWad9h0FHyVIjE2DoW-aeTIze0xaQ_HFndunJBzccZ1EQYe7ww== 10:05:17 INFO - x-amz-version-id: m1dnlO.024PRP3MTrohQR6kdFKI7sQjH 10:05:17 INFO - Expected file size: 16092080 10:05:17 INFO - Obtained file size: 16092080 10:05:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dqyKb6dVTjmf1FK_9gQXYQ/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 10:05:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dqyKb6dVTjmf1FK_9gQXYQ/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 10:05:24 INFO - Fetch https://queue.taskcluster.net/v1/task/dqyKb6dVTjmf1FK_9gQXYQ/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 10:05:25 INFO - Http code: 200 10:05:25 INFO - via: 1.1 b9a8ce441329f20cea895e08f19f1ec8.cloudfront.net (CloudFront) 10:05:25 INFO - x-amz-cf-id: PN02vPhJbBqKYxWa09emx9Vr7WSASkeqjxvfgzMECWkQhPyGLTiJKQ== 10:05:25 INFO - x-amz-version-id: JIScwb5vS15tewzLnFVnLXXpDAtmCxDk 10:05:25 INFO - Expected file size: 14403005 10:05:25 INFO - Obtained file size: 14403005 10:05:26 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')]} 10:05:26 INFO - trying https://queue.taskcluster.net/v1/task/dqyKb6dVTjmf1FK_9gQXYQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg 10:05:26 INFO - Downloading https://queue.taskcluster.net/v1/task/dqyKb6dVTjmf1FK_9gQXYQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 10:05:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dqyKb6dVTjmf1FK_9gQXYQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg'}, attempt #1 10:05:28 INFO - Downloaded 82132975 bytes. 10:05:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dqyKb6dVTjmf1FK_9gQXYQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg 10:05:28 INFO - mkdir: /builds/slave/test/properties 10:05:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:05:28 INFO - Writing to file /builds/slave/test/properties/build_url 10:05:28 INFO - Contents: 10:05:28 INFO - build_url:https://queue.taskcluster.net/v1/task/dqyKb6dVTjmf1FK_9gQXYQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg 10:05:29 INFO - Running post-action listener: _resource_record_post_action 10:05:29 INFO - Running post-action listener: set_extra_try_arguments 10:05:29 INFO - [mozharness: 2017-02-03 18:05:29.204801Z] Finished download-and-extract step (success) 10:05:29 INFO - [mozharness: 2017-02-03 18:05:29.204932Z] Running populate-webroot step. 10:05:29 INFO - Running pre-action listener: _resource_record_pre_action 10:05:29 INFO - Running main action method: populate_webroot 10:05:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:05:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:05:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:05:29 INFO - '--tppagecycles', 10:05:29 INFO - '7'], 10:05:29 INFO - 'tests': ['tsvgm']}}, 10:05:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:05:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:05:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:05:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:05:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:05:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:05:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:29 INFO - 'talos_options': ['--disable-e10s'], 10:05:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:05:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:05:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:29 INFO - 'talos_options': ['--disable-e10s'], 10:05:29 INFO - 'tests': ['damp', 'tps']}, 10:05:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:29 INFO - 'tests': ['damp', 'tps']}, 10:05:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:05:29 INFO - 'tests': ['dromaeo_dom']}, 10:05:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:05:29 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:05:29 INFO - 'tests': ['basic_compositor_video']}, 10:05:29 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:05:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:05:29 INFO - 'tests': ['a11yr', 10:05:29 INFO - 'ts_paint', 10:05:29 INFO - 'tpaint', 10:05:29 INFO - 'sessionrestore', 10:05:29 INFO - 'sessionrestore_no_auto_restore', 10:05:29 INFO - 'tabpaint']}, 10:05:29 INFO - 'other-e10s': {'tests': ['a11yr', 10:05:29 INFO - 'ts_paint', 10:05:29 INFO - 'tpaint', 10:05:29 INFO - 'sessionrestore', 10:05:29 INFO - 'sessionrestore_no_auto_restore', 10:05:29 INFO - 'tabpaint']}, 10:05:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:05:29 INFO - 'ts_paint', 10:05:29 INFO - 'tpaint', 10:05:29 INFO - 'sessionrestore', 10:05:29 INFO - 'sessionrestore_no_auto_restore', 10:05:29 INFO - 'tabpaint']}, 10:05:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:05:29 INFO - 'ts_paint', 10:05:29 INFO - 'tpaint', 10:05:29 INFO - 'sessionrestore', 10:05:29 INFO - 'sessionrestore_no_auto_restore', 10:05:29 INFO - 'tabpaint']}, 10:05:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:05:29 INFO - 'tests': ['a11yr', 10:05:29 INFO - 'ts_paint', 10:05:29 INFO - 'tpaint', 10:05:29 INFO - 'sessionrestore', 10:05:29 INFO - 'sessionrestore_no_auto_restore', 10:05:29 INFO - 'tabpaint']}, 10:05:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:05:29 INFO - 'tests': ['a11yr', 10:05:29 INFO - 'ts_paint', 10:05:29 INFO - 'tpaint', 10:05:29 INFO - 'sessionrestore', 10:05:29 INFO - 'sessionrestore_no_auto_restore', 10:05:29 INFO - 'tabpaint']}, 10:05:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:05:29 INFO - 'tests': ['tsvgx', 10:05:29 INFO - 'tsvgr_opacity', 10:05:29 INFO - 'tart', 10:05:29 INFO - 'tscrollx', 10:05:29 INFO - 'cart']}, 10:05:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:05:29 INFO - 'tsvgr_opacity', 10:05:29 INFO - 'tart', 10:05:29 INFO - 'tscrollx', 10:05:29 INFO - 'cart']}, 10:05:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:29 INFO - 'talos_options': ['--disable-e10s'], 10:05:29 INFO - 'tests': ['tp5o']}, 10:05:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:29 INFO - 'tests': ['tp5o']}, 10:05:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:29 INFO - 'talos_options': ['--disable-e10s', 10:05:29 INFO - '--xperf_path', 10:05:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:05:29 INFO - 'tests': ['tp5n']}, 10:05:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:05:29 INFO - 'talos_options': ['--xperf_path', 10:05:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:05:29 INFO - 'tests': ['tp5n']}}, 10:05:29 INFO - 'talos.zip': {'path': '', 10:05:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:05:29 INFO - Running post-action listener: _resource_record_post_action 10:05:29 INFO - [mozharness: 2017-02-03 18:05:29.223735Z] Finished populate-webroot step (success) 10:05:29 INFO - [mozharness: 2017-02-03 18:05:29.223825Z] Running create-virtualenv step. 10:05:29 INFO - Running pre-action listener: _resource_record_pre_action 10:05:29 INFO - Running main action method: create_virtualenv 10:05:29 INFO - Creating virtualenv /builds/slave/test/build/venv 10:05:29 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 10:05:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:05:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:05:29 INFO - Using real prefix '/tools/python27' 10:05:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:05:30 INFO - Installing distribute.............................................................................................................................................................................................done. 10:05:32 INFO - Installing pip.................done. 10:05:32 INFO - Return code: 0 10:05:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:05:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:05:33 INFO - Reading from file tmpfile_stdout 10:05:33 INFO - Output received: 10:05:33 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) 10:05:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:05: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')]} 10:05:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05: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')]} 10:05:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:33 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 0x10290f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102885570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbf955d390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102723d30>, '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 0x102589db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10271bb20>, '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.qivElZA6ZR/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.QWiOqwkFRz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/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 10:05:33 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 10:05:33 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 10:05:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qivElZA6ZR/Render', 10:05:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:05:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:05:33 INFO - 'HOME': '/Users/cltbld', 10:05:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:05:33 INFO - 'LOGNAME': 'cltbld', 10:05:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:33 INFO - 'MOZ_NO_REMOTE': '1', 10:05:33 INFO - 'NO_EM_RESTART': '1', 10:05:33 INFO - 'PAGER': '/bin/cat', 10:05:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:05:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:33 INFO - 'PWD': '/builds/slave/test', 10:05:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:05:33 INFO - 'SHELL': '/bin/bash', 10:05:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QWiOqwkFRz/Listeners', 10:05:33 INFO - 'TMPDIR': '/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/', 10:05:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:05:33 INFO - 'USER': 'cltbld', 10:05:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:05:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:05:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:33 INFO - 'XPC_FLAGS': '0x0', 10:05:33 INFO - 'XPC_SERVICE_NAME': '0', 10:05:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:05:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:33 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 10:05:33 INFO - Cleaning up... 10:05:33 INFO - Return code: 0 10:05:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:05: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')]} 10:05:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05: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')]} 10:05:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:33 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 0x10290f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102885570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbf955d390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102723d30>, '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 0x102589db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10271bb20>, '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.qivElZA6ZR/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.QWiOqwkFRz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/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 10:05:33 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 10:05:33 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 10:05:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qivElZA6ZR/Render', 10:05:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:05:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:05:33 INFO - 'HOME': '/Users/cltbld', 10:05:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:05:33 INFO - 'LOGNAME': 'cltbld', 10:05:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:33 INFO - 'MOZ_NO_REMOTE': '1', 10:05:33 INFO - 'NO_EM_RESTART': '1', 10:05:33 INFO - 'PAGER': '/bin/cat', 10:05:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:05:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:33 INFO - 'PWD': '/builds/slave/test', 10:05:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:05:33 INFO - 'SHELL': '/bin/bash', 10:05:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QWiOqwkFRz/Listeners', 10:05:33 INFO - 'TMPDIR': '/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/', 10:05:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:05:33 INFO - 'USER': 'cltbld', 10:05:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:05:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:05:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:33 INFO - 'XPC_FLAGS': '0x0', 10:05:33 INFO - 'XPC_SERVICE_NAME': '0', 10:05:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:05:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:33 INFO - Downloading/unpacking psutil>=3.1.1 10:05:33 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 10:05:33 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 10:05:33 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 10:05:33 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 10:05:33 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 10:05:33 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 10:05:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:05:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:05:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:05:37 INFO - Installing collected packages: psutil 10:05:37 INFO - Running setup.py install for psutil 10:05:37 INFO - building 'psutil._psutil_osx' extension 10:05:37 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 10:05:37 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 10:05:37 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 10:05:37 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 10:05:38 INFO - building 'psutil._psutil_posix' extension 10:05:38 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 10:05:38 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:05:38 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:05:38 INFO - ^ 10:05:38 INFO - 1 warning generated. 10:05:38 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 10:05:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:05:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:05:38 INFO - Successfully installed psutil 10:05:38 INFO - Cleaning up... 10:05:38 INFO - Return code: 0 10:05:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:05:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10290f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102885570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbf955d390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102723d30>, '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 0x102589db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10271bb20>, '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.qivElZA6ZR/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.QWiOqwkFRz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/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 10:05:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:05:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:05:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qivElZA6ZR/Render', 10:05:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:05:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:05:38 INFO - 'HOME': '/Users/cltbld', 10:05:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:05:38 INFO - 'LOGNAME': 'cltbld', 10:05:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:38 INFO - 'MOZ_NO_REMOTE': '1', 10:05:38 INFO - 'NO_EM_RESTART': '1', 10:05:38 INFO - 'PAGER': '/bin/cat', 10:05:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:05:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:38 INFO - 'PWD': '/builds/slave/test', 10:05:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:05:38 INFO - 'SHELL': '/bin/bash', 10:05:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QWiOqwkFRz/Listeners', 10:05:38 INFO - 'TMPDIR': '/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/', 10:05:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:05:38 INFO - 'USER': 'cltbld', 10:05:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:05:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:05:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:38 INFO - 'XPC_FLAGS': '0x0', 10:05:38 INFO - 'XPC_SERVICE_NAME': '0', 10:05:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:05:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:05:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:05:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:05:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:05:41 INFO - Installing collected packages: mozsystemmonitor 10:05:41 INFO - Running setup.py install for mozsystemmonitor 10:05:41 INFO - Successfully installed mozsystemmonitor 10:05:41 INFO - Cleaning up... 10:05:41 INFO - Return code: 0 10:05:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:05:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:05:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10290f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102885570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbf955d390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102723d30>, '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 0x102589db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10271bb20>, '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.qivElZA6ZR/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.QWiOqwkFRz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/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 10:05:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:05:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:05:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qivElZA6ZR/Render', 10:05:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:05:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:05:41 INFO - 'HOME': '/Users/cltbld', 10:05:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:05:41 INFO - 'LOGNAME': 'cltbld', 10:05:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:41 INFO - 'MOZ_NO_REMOTE': '1', 10:05:41 INFO - 'NO_EM_RESTART': '1', 10:05:41 INFO - 'PAGER': '/bin/cat', 10:05:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:05:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:41 INFO - 'PWD': '/builds/slave/test', 10:05:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:05:41 INFO - 'SHELL': '/bin/bash', 10:05:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QWiOqwkFRz/Listeners', 10:05:41 INFO - 'TMPDIR': '/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/', 10:05:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:05:41 INFO - 'USER': 'cltbld', 10:05:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:05:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:05:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:41 INFO - 'XPC_FLAGS': '0x0', 10:05:41 INFO - 'XPC_SERVICE_NAME': '0', 10:05:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:05:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:41 INFO - Downloading/unpacking jsonschema==2.5.1 10:05:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:05:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:05:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:05:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:05:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:05:44 INFO - Downloading functools32-3.2.3-2.tar.gz 10:05:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:05:44 INFO - warning: no files found matching '*.txt' 10:05:44 INFO - no previously-included directories found matching 'build' 10:05:44 INFO - no previously-included directories found matching 'dist' 10:05:44 INFO - no previously-included directories found matching '.git*' 10:05:44 INFO - Installing collected packages: jsonschema, functools32 10:05:44 INFO - Running setup.py install for functools32 10:05:44 INFO - warning: no files found matching '*.txt' 10:05:44 INFO - no previously-included directories found matching 'build' 10:05:44 INFO - no previously-included directories found matching 'dist' 10:05:44 INFO - no previously-included directories found matching '.git*' 10:05:45 INFO - Successfully installed jsonschema functools32 10:05:45 INFO - Cleaning up... 10:05:45 INFO - Return code: 0 10:05:45 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:05: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')]} 10:05:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05: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')]} 10:05:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05: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', '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 0x10290f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102885570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbf955d390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102723d30>, '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 0x102589db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10271bb20>, '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.qivElZA6ZR/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.QWiOqwkFRz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/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 10:05: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:05: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 functools32==3.2.3-2 10:05:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qivElZA6ZR/Render', 10:05:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:05:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:05:45 INFO - 'HOME': '/Users/cltbld', 10:05:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:05:45 INFO - 'LOGNAME': 'cltbld', 10:05:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:45 INFO - 'MOZ_NO_REMOTE': '1', 10:05:45 INFO - 'NO_EM_RESTART': '1', 10:05:45 INFO - 'PAGER': '/bin/cat', 10:05:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:05:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:45 INFO - 'PWD': '/builds/slave/test', 10:05:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:05:45 INFO - 'SHELL': '/bin/bash', 10:05:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QWiOqwkFRz/Listeners', 10:05:45 INFO - 'TMPDIR': '/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/', 10:05:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:05:45 INFO - 'USER': 'cltbld', 10:05:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:05:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:05:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:45 INFO - 'XPC_FLAGS': '0x0', 10:05:45 INFO - 'XPC_SERVICE_NAME': '0', 10:05:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:05:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:45 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:05:45 INFO - Cleaning up... 10:05:45 INFO - Return code: 0 10:05:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:05: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')]} 10:05:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05: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')]} 10:05:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05: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', '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 0x10290f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102885570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbf955d390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102723d30>, '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 0x102589db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10271bb20>, '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.qivElZA6ZR/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.QWiOqwkFRz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/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 10:05: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:05: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 blobuploader==1.2.4 10:05:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qivElZA6ZR/Render', 10:05:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:05:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:05:45 INFO - 'HOME': '/Users/cltbld', 10:05:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:05:45 INFO - 'LOGNAME': 'cltbld', 10:05:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:45 INFO - 'MOZ_NO_REMOTE': '1', 10:05:45 INFO - 'NO_EM_RESTART': '1', 10:05:45 INFO - 'PAGER': '/bin/cat', 10:05:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:05:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:45 INFO - 'PWD': '/builds/slave/test', 10:05:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:05:45 INFO - 'SHELL': '/bin/bash', 10:05:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QWiOqwkFRz/Listeners', 10:05:45 INFO - 'TMPDIR': '/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/', 10:05:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:05:45 INFO - 'USER': 'cltbld', 10:05:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:05:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:05:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:45 INFO - 'XPC_FLAGS': '0x0', 10:05:45 INFO - 'XPC_SERVICE_NAME': '0', 10:05:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:05:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:45 INFO - Downloading/unpacking blobuploader==1.2.4 10:05: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 10:05: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 10:05: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 10:05: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 10:05: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 10:05: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 10:05:48 INFO - Downloading blobuploader-1.2.4.tar.gz 10:05:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:05:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:05: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 10:05: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 10:05: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 10:05: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 10:05: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 10:05: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 10:05:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:05:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:05: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 10:05: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 10:05: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 10:05: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 10:05: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 10:05: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 10:05:49 INFO - Downloading docopt-0.6.1.tar.gz 10:05:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:05:49 INFO - Installing collected packages: blobuploader, requests, docopt 10:05:49 INFO - Running setup.py install for blobuploader 10:05:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:05:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:05:49 INFO - Running setup.py install for requests 10:05:50 INFO - Running setup.py install for docopt 10:05:50 INFO - Successfully installed blobuploader requests docopt 10:05:50 INFO - Cleaning up... 10:05:50 INFO - Return code: 0 10:05:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:05:50 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')]} 10:05:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:50 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')]} 10:05:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:50 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 0x10290f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102885570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbf955d390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102723d30>, '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 0x102589db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10271bb20>, '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.qivElZA6ZR/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.QWiOqwkFRz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/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 10:05:50 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 10:05:50 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 10:05:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qivElZA6ZR/Render', 10:05:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:05:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:05:50 INFO - 'HOME': '/Users/cltbld', 10:05:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:05:50 INFO - 'LOGNAME': 'cltbld', 10:05:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:50 INFO - 'MOZ_NO_REMOTE': '1', 10:05:50 INFO - 'NO_EM_RESTART': '1', 10:05:50 INFO - 'PAGER': '/bin/cat', 10:05:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:05:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:50 INFO - 'PWD': '/builds/slave/test', 10:05:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:05:50 INFO - 'SHELL': '/bin/bash', 10:05:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QWiOqwkFRz/Listeners', 10:05:50 INFO - 'TMPDIR': '/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/', 10:05:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:05:50 INFO - 'USER': 'cltbld', 10:05:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:05:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:05:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:50 INFO - 'XPC_FLAGS': '0x0', 10:05:50 INFO - 'XPC_SERVICE_NAME': '0', 10:05:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:05:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:05:50 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-01jQGW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:05:50 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-yX7x4W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:05:50 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-xLDEg2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:05:50 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-F5NCFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:05:51 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-u5K28n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:05:51 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-4XPelf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:05:51 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-EhUBY3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:05:51 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-Y3sNxG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:05:51 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-VU8bl3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:05:51 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-o0e_cG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:05:51 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-ZJeAVc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:05:51 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-oftY_j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:05:51 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-7KEZlN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:05:52 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-cDxPSd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:05:52 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-L9tbWb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:05:52 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-_MWOZE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:05:52 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-m6lchr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:05:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:05:52 INFO - Running setup.py install for manifestparser 10:05:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:05:52 INFO - Running setup.py install for mozcrash 10:05:52 INFO - Running setup.py install for mozdebug 10:05:52 INFO - Running setup.py install for mozdevice 10:05:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:05:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:05:53 INFO - Running setup.py install for mozfile 10:05:53 INFO - Running setup.py install for mozhttpd 10:05:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:05:53 INFO - Running setup.py install for mozinfo 10:05:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:05:53 INFO - Running setup.py install for mozInstall 10:05:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:05:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:05:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:05:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:05:53 INFO - Running setup.py install for mozleak 10:05:53 INFO - Running setup.py install for mozlog 10:05:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:05:53 INFO - Running setup.py install for moznetwork 10:05:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:05:54 INFO - Running setup.py install for mozprocess 10:05:54 INFO - Running setup.py install for mozprofile 10:05:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:05:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:05:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:05:54 INFO - Running setup.py install for mozrunner 10:05:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:05:54 INFO - Running setup.py install for mozscreenshot 10:05:54 INFO - Running setup.py install for moztest 10:05:54 INFO - Running setup.py install for mozversion 10:05:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:05:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:05:54 INFO - Cleaning up... 10:05:55 INFO - Return code: 0 10:05:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:05:55 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')]} 10:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:05:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:55 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')]} 10:05:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:05:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:05:55 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 0x10290f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102885570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbf955d390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102723d30>, '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 0x102589db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10271bb20>, '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.qivElZA6ZR/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.QWiOqwkFRz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/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 10:05:55 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 10:05:55 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 10:05:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qivElZA6ZR/Render', 10:05:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:05:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:05:55 INFO - 'HOME': '/Users/cltbld', 10:05:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:05:55 INFO - 'LOGNAME': 'cltbld', 10:05:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:55 INFO - 'MOZ_NO_REMOTE': '1', 10:05:55 INFO - 'NO_EM_RESTART': '1', 10:05:55 INFO - 'PAGER': '/bin/cat', 10:05:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:05:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:05:55 INFO - 'PWD': '/builds/slave/test', 10:05:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:05:55 INFO - 'SHELL': '/bin/bash', 10:05:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QWiOqwkFRz/Listeners', 10:05:55 INFO - 'TMPDIR': '/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/', 10:05:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:05:55 INFO - 'USER': 'cltbld', 10:05:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:05:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:05:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:55 INFO - 'XPC_FLAGS': '0x0', 10:05:55 INFO - 'XPC_SERVICE_NAME': '0', 10:05:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:05:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:05:55 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-XMw_IV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:05:55 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)) 10:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:05:55 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-GMMkN_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:05:55 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)) 10:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:05:55 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-kWeQk2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:05:55 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)) 10:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:05:55 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-jCbx68-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:05:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 10:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:05:55 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-hckZQe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:05:55 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)) 10:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:05:55 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-sVMS7h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:05:55 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)) 10:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:05:55 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-4EVF35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:05:56 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)) 10:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:05:56 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-jxq5lT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:05:56 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)) 10:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:05:56 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-OzlQSn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:05:56 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)) 10:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:05:56 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-KrMuHb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:05:56 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)) 10:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:05:56 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-hsNNcj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:05:56 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)) 10:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:05:56 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-A8rm3O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:05:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:05:56 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-7730N4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:05:56 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)) 10:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:05:56 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-TMwLzp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:05:56 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)) 10:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:05:56 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-yIb1hz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:05:56 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)) 10:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:05:56 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-4u40uQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:05:56 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)) 10:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:05:56 INFO - Running setup.py (path:/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/pip-py5s58-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:05:57 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)) 10:05:57 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)) 10:05:57 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)) 10:05:57 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)) 10:05:57 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:05:57 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:05:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:05:57 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 10:05:57 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 10:05:57 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 10:05:57 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 10:05:57 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 10:05:57 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 10:05:59 INFO - Downloading blessings-1.6.tar.gz 10:05:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:05:59 INFO - Installing collected packages: blessings 10:05:59 INFO - Running setup.py install for blessings 10:06:00 INFO - Successfully installed blessings 10:06:00 INFO - Cleaning up... 10:06:00 INFO - Return code: 0 10:06:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:06:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:06:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:06:00 INFO - Reading from file tmpfile_stdout 10:06:00 INFO - Current package versions: 10:06:00 INFO - blessings == 1.6 10:06:00 INFO - blobuploader == 1.2.4 10:06:00 INFO - docopt == 0.6.1 10:06:00 INFO - functools32 == 3.2.3-2 10:06:00 INFO - jsonschema == 2.5.1 10:06:00 INFO - manifestparser == 1.1 10:06:00 INFO - mozInstall == 1.12 10:06:00 INFO - mozcrash == 1.0 10:06:00 INFO - mozdebug == 0.1 10:06:00 INFO - mozdevice == 0.48 10:06:00 INFO - mozfile == 1.2 10:06:00 INFO - mozhttpd == 0.7 10:06:00 INFO - mozinfo == 0.9 10:06:00 INFO - mozleak == 0.1 10:06:00 INFO - mozlog == 3.4 10:06:00 INFO - moznetwork == 0.27 10:06:00 INFO - mozprocess == 0.23 10:06:00 INFO - mozprofile == 0.28 10:06:00 INFO - mozrunner == 6.13 10:06:00 INFO - mozscreenshot == 0.1 10:06:00 INFO - mozsystemmonitor == 0.3 10:06:00 INFO - moztest == 0.8 10:06:00 INFO - mozversion == 1.4 10:06:00 INFO - psutil == 3.1.1 10:06:00 INFO - requests == 1.2.3 10:06:00 INFO - wsgiref == 0.1.2 10:06:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:06:00 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')]} 10:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:00 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')]} 10:06:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:01 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 0x10290f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102885570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbf955d390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102723d30>, '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 0x102589db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10271bb20>, '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.qivElZA6ZR/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.QWiOqwkFRz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/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 10:06:01 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 10:06:01 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 10:06:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qivElZA6ZR/Render', 10:06:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:06:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:06:01 INFO - 'HOME': '/Users/cltbld', 10:06:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:06:01 INFO - 'LOGNAME': 'cltbld', 10:06:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:01 INFO - 'MOZ_NO_REMOTE': '1', 10:06:01 INFO - 'NO_EM_RESTART': '1', 10:06:01 INFO - 'PAGER': '/bin/cat', 10:06:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:06:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:01 INFO - 'PWD': '/builds/slave/test', 10:06:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:06:01 INFO - 'SHELL': '/bin/bash', 10:06:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QWiOqwkFRz/Listeners', 10:06:01 INFO - 'TMPDIR': '/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/', 10:06:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:06:01 INFO - 'USER': 'cltbld', 10:06:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:06:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:06:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:01 INFO - 'XPC_FLAGS': '0x0', 10:06:01 INFO - 'XPC_SERVICE_NAME': '0', 10:06:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:06:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:01 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)) 10:06:01 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)) 10:06:01 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)) 10:06:01 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)) 10:06:01 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)) 10:06:01 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)) 10:06:01 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)) 10:06:01 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)) 10:06:01 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)) 10:06:01 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)) 10:06:01 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)) 10:06:01 INFO - Cleaning up... 10:06:01 INFO - Return code: 0 10:06:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:06:01 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')]} 10:06:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:01 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')]} 10:06:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:06:01 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 0x10290f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102885570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbf955d390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102723d30>, '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 0x102589db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10271bb20>, '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.qivElZA6ZR/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.QWiOqwkFRz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/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 10:06:01 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 10:06:01 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 10:06:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qivElZA6ZR/Render', 10:06:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:06:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:06:01 INFO - 'HOME': '/Users/cltbld', 10:06:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:06:01 INFO - 'LOGNAME': 'cltbld', 10:06:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:01 INFO - 'MOZ_NO_REMOTE': '1', 10:06:01 INFO - 'NO_EM_RESTART': '1', 10:06:01 INFO - 'PAGER': '/bin/cat', 10:06:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:06:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:01 INFO - 'PWD': '/builds/slave/test', 10:06:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:06:01 INFO - 'SHELL': '/bin/bash', 10:06:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QWiOqwkFRz/Listeners', 10:06:01 INFO - 'TMPDIR': '/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/', 10:06:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:06:01 INFO - 'USER': 'cltbld', 10:06:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:06:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:06:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:01 INFO - 'XPC_FLAGS': '0x0', 10:06:01 INFO - 'XPC_SERVICE_NAME': '0', 10:06:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:06:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:06:02 INFO - Cleaning up... 10:06:02 INFO - Return code: 0 10:06:02 INFO - Running post-action listener: _resource_record_post_action 10:06:02 INFO - Running post-action listener: _start_resource_monitoring 10:06:02 INFO - Starting resource monitoring. 10:06:02 INFO - [mozharness: 2017-02-03 18:06:02.168390Z] Finished create-virtualenv step (success) 10:06:02 INFO - [mozharness: 2017-02-03 18:06:02.169345Z] Running install step. 10:06:02 INFO - Running pre-action listener: _resource_record_pre_action 10:06:02 INFO - Running main action method: install 10:06:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:06:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:06:02 INFO - Reading from file tmpfile_stdout 10:06:02 INFO - Detecting whether we're running mozinstall >=1.0... 10:06:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:06:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:06:02 INFO - Reading from file tmpfile_stdout 10:06:02 INFO - Output received: 10:06:02 INFO - Usage: mozinstall [options] installer 10:06:02 INFO - Options: 10:06:02 INFO - -h, --help show this help message and exit 10:06:02 INFO - -d DEST, --destination=DEST 10:06:02 INFO - Directory to install application into. [default: 10:06:02 INFO - "/builds/slave/test"] 10:06:02 INFO - --app=APP Application being installed. [default: firefox] 10:06:02 INFO - mkdir: /builds/slave/test/build/application 10:06:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:06:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.mac.dmg --destination /builds/slave/test/build/application 10:06:23 INFO - Reading from file tmpfile_stdout 10:06:23 INFO - Output received: 10:06:23 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 10:06:23 INFO - Running post-action listener: _resource_record_post_action 10:06:23 INFO - [mozharness: 2017-02-03 18:06:23.929408Z] Finished install step (success) 10:06:23 INFO - [mozharness: 2017-02-03 18:06:23.929559Z] Running run-tests step. 10:06:23 INFO - Running pre-action listener: _resource_record_pre_action 10:06:23 INFO - Running main action method: run_tests 10:06:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:06:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:06:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:06:23 INFO - 2017-02-03 10:06:23.944 screenresolution[1627:7368] starting screenresolution argv=screenresolution get 10:06:23 INFO - 2017-02-03 10:06:23.946 screenresolution[1627:7368] Display 0: 1600x1200x32@60 10:06:23 INFO - 2017-02-03 10:06:23.952 screenresolution[1628:7370] starting screenresolution argv=screenresolution list 10:06:23 INFO - Available Modes on Display 0 10:06:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:06:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:06:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:06:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:06:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:06:24 INFO - Intel Iris: 10:06:24 INFO - Chipset Model: Intel Iris 10:06:24 INFO - Type: GPU 10:06:24 INFO - Bus: Built-In 10:06:24 INFO - VRAM (Dynamic, Max): 1536 MB 10:06:24 INFO - Vendor: Intel (0x8086) 10:06:24 INFO - Device ID: 0x0a2e 10:06:24 INFO - Revision ID: 0x0009 10:06:24 INFO - Displays: 10:06:24 INFO - Display: 10:06:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:06:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:06:24 INFO - Display Serial Number: 1600x1200 60 10:06:24 INFO - Main Display: Yes 10:06:24 INFO - Mirror: Off 10:06:24 INFO - Online: Yes 10:06:24 INFO - Rotation: Supported 10:06:24 INFO - Return code: 0 10:06:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:06:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:06:24 INFO - Python 2.7.3 10:06:24 INFO - Return code: 0 10:06:24 INFO - grabbing minidump binary from tooltool 10:06:24 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')]} 10:06:24 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 0x102723d30>, '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 0x102589db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10271bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:06:24 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 10:06:24 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 10:06:24 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 10:06:24 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:06:24 INFO - Return code: 0 10:06:24 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:06:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:06:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:06:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:06:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:06:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dqyKb6dVTjmf1FK_9gQXYQ/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0324', '--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 10:06:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dqyKb6dVTjmf1FK_9gQXYQ/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0324 --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 10:06:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qivElZA6ZR/Render', 10:06:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:06:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:06:24 INFO - 'HOME': '/Users/cltbld', 10:06:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:06:24 INFO - 'LOGNAME': 'cltbld', 10:06:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:06:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:06:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:24 INFO - 'MOZ_NO_REMOTE': '1', 10:06:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:06:24 INFO - 'NO_EM_RESTART': '1', 10:06:24 INFO - 'PAGER': '/bin/cat', 10:06:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:06:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:24 INFO - 'PWD': '/builds/slave/test', 10:06:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:06:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:06:24 INFO - 'SHELL': '/bin/bash', 10:06:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QWiOqwkFRz/Listeners', 10:06:24 INFO - 'TMPDIR': '/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/', 10:06:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:06:24 INFO - 'USER': 'cltbld', 10:06:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:06:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:06:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:24 INFO - 'XPC_FLAGS': '0x0', 10:06:24 INFO - 'XPC_SERVICE_NAME': '0', 10:06:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:06:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dqyKb6dVTjmf1FK_9gQXYQ/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0324', '--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 10:06:24 INFO - mozversion application_buildid: 20170203074109 10:06:24 INFO - mozversion application_changeset: cb874e871110d67e78f2c8bc37b618ebb9ba0e4c 10:06:24 INFO - mozversion application_display_name: Firefox 10:06:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:06:24 INFO - mozversion application_name: Firefox 10:06:24 INFO - mozversion application_remotingname: firefox 10:06:24 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 10:06:24 INFO - mozversion application_vendor: Mozilla 10:06:24 INFO - mozversion application_version: 52.0 10:06:24 INFO - mozversion platform_buildid: 20170203074109 10:06:24 INFO - mozversion platform_changeset: cb874e871110d67e78f2c8bc37b618ebb9ba0e4c 10:06:24 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 10:06:24 INFO - mozversion platform_version: 52.0 10:06:24 INFO - using testdate: 1486145184 10:06:24 INFO - actual date: 1486145184 10:06:24 INFO - starting webserver on 'localhost:49249' 10:06:24 INFO - SUITE-START | Running 2 tests 10:06:24 INFO - TEST-START | dromaeo_css 10:06:24 INFO - operating with platform_type : mac_ 10:06:24 INFO - Initialising browser for dromaeo_css test... 10:06:24 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/tmpgD4pzK/profile http://localhost:49249/getInfo.html) 10:06:27 INFO - PROCESS | 1638 | 2017-02-03 10:06:27.627 plugin-container[1641:7547] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4d4b, name = 'com.apple.tsm.portname' 10:06:27 INFO - PROCESS | 1638 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:06:27 INFO - PROCESS | 1638 | 2017-02-03 10:06:27.628 plugin-container[1641:7547] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c33, name = 'com.apple.CFPasteboardClient' 10:06:27 INFO - PROCESS | 1638 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:06:27 INFO - PROCESS | 1638 | 2017-02-03 10:06:27.628 plugin-container[1641:7547] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:06:27 INFO - PROCESS | 1638 | __metrics Screen width/height:1600/1200 10:06:27 INFO - PROCESS | 1638 | colorDepth:24 10:06:27 INFO - PROCESS | 1638 | Browser inner width/height: 1024/689 10:06:27 INFO - PROCESS | 1638 | __metrics 10:06:27 ERROR - PROCESS | 1638 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3197: TypeError: this.tabs is undefined 10:06:28 INFO - TEST-INFO | 1638: exit 0 10:06:28 INFO - Browser initialized. 10:06:28 INFO - Running cycle 1/1 for dromaeo_css test... 10:06:28 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/tmpgD4pzK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:06:30 INFO - PROCESS | 1642 | 2017-02-03 10:06:30.792 plugin-container[1643:7670] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4447, name = 'com.apple.tsm.portname' 10:06:30 INFO - PROCESS | 1642 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:06:30 INFO - PROCESS | 1642 | 2017-02-03 10:06:30.793 plugin-container[1643:7670] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b0b, name = 'com.apple.CFPasteboardClient' 10:06:30 INFO - PROCESS | 1642 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:06:30 INFO - PROCESS | 1642 | 2017-02-03 10:06:30.793 plugin-container[1643:7670] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:06:40 INFO - PROCESS | 1642 | RSS: Main: 177389568 10:06:40 INFO - PROCESS | 1642 | 10:09:42 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49249/tests/dromaeo/cssquery-ext.html) 10:09:44 INFO - PROCESS | 1642 | RSS: Main: 182599680 10:09:44 INFO - PROCESS | 1642 | 10:12:46 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-ext.html (next: http://localhost:49249/tests/dromaeo/cssquery-jquery.html) 10:12:47 INFO - PROCESS | 1642 | RSS: Main: 191475712 10:12:47 INFO - PROCESS | 1642 | 10:15:49 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49249/tests/dromaeo/cssquery-mootools.html) 10:15:49 INFO - PROCESS | 1642 | RSS: Main: 198275072 10:15:49 INFO - PROCESS | 1642 | 10:18:51 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49249/tests/dromaeo/cssquery-prototype.html) 10:18:52 INFO - PROCESS | 1642 | RSS: Main: 201334784 10:18:52 INFO - PROCESS | 1642 | 10:21:54 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49249/tests/dromaeo/cssquery-yui.html) 10:21:55 INFO - PROCESS | 1642 | RSS: Main: 203751424 10:21:55 INFO - PROCESS | 1642 | 10:24:58 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-yui.html (next: http://localhost:49249/tests/dromaeo/cssquery-dojo.html) 10:24:58 INFO - PROCESS | 1642 | RSS: Main: 204148736 10:24:58 INFO - PROCESS | 1642 | 10:24:58 INFO - PROCESS | 1642 | __start_tp_report 10:24:58 INFO - PROCESS | 1642 | _x_x_mozilla_page_load 10:24:58 INFO - PROCESS | 1642 | _x_x_mozilla_page_load_details 10:24:58 INFO - PROCESS | 1642 | |i|pagename|runs| 10:24:58 INFO - PROCESS | 1642 | |0;dojo.html;3539.5929468111167;3540.3450361683076;3559.6084430712617;3568.33985712643;3594.2991116732233;5848.093545500449;5881.558883083764;5905.173275741395;5924.703764811764;5936.228290322252;5902.498287645555;5977.372375900533;5984.940150598503;5998.310194327653;6004.099385092239;5070.543651071403;5252.973735131319;5321.095413779647;5366.302380690505;5388.541973932201;5367.865803354928;5404.432534583871;5408.296921400212;5409.756560954746;5418.972905135469;5233.476652334774;5285.180796976456;5400;5404.162354834987;5447.782088716446;4451.710638808499;5295.126304159809;5341;5364.544013758796;5430.538404235605;5210.426853046162;5308.230306605559;5326.7070311132875;5353.57171426285;5377.489138531833;4991.650584459089;5698.971505142489;5830.737616807211;5933.703314834241;5973.910391344133;6161.137440758297;6190.89509566745;6195.0707393890825;6199.194104766351;6246.906296405557;6300.842478938017;6322.209723784527;6322.336154703736;6336.588121772116;6405.7757978471;5235.319408476912;6027.517798576191;6047;6068.75724971005;6087.308366677171;6194.0708893665405;6270.905936410957;6283.02613094971;6342.365763423621;6391.648459334689;6210.31686514483;6219.626822390671;6244.531660125509;6274.435300822948;6294.874102517924;6280.152179455807;6295.527835412362;6309.022101574264;6321.936780632227;6327.987521996551;6178.320384757673;6210.441060304594;6211.192544969215;6222.066689996536;6292.056191571301;6226.40849119342;6241.438270555581;6249.78125765596;6259.655718935411;6283.434490895841;5040.420351659533;5043.420006699203;5055.7219352935945;5078.314427552307;5078.5175408336145;4434.800433980478;4437.600615944581;4461.843835465808;4551.089782043538;4561.840335588238;5872.412758724179;5919.496842768327;5952.077427998667;6034.1853849730605;6079.756809727562;5918;6014.0678194879865;6286.748530058747;6305.905411418832;6322.0200868865395;5769.68266745333;5884.382139875337;5892.616979896293;5934.080217566284;5951.345352011275;5529.115341545414;5534.75093620788;5536.058869992111;5544.584156188222;5552.194931734876;6449.6130232186215;6507.837304067436;6508.609483431104;6509.349065093642;6520.706568204348;6135.018317212141;6169.5064394849205;6201.224846894138;6209.503239740719;6291.905621415774;6434.388733070351;6448.258450278278;6458.967705161444;6463.289038205699;6475.676216189266;5216.765245564035;6255.96872015637;6260.40526150015;6263.279722831932;6284.4344009039405;6145.525073982123;6238.937610623836;6241.937580624136;6255.31191568918;6264.68676566179;5383.757730902041;6113.358097399709;6129.205975626662;6233.75064997395;6255.186825712628;6160.13758073861;6196.783112591038;6199.380061993765;6241.095041218907;6257.8748425030335;5989.251343582052;6002.279726432856;6068.241469816273;6108.144859719731;6115.663638499926;6112.5946701277735;6128.319797384489;6142.959235178615;6235.625862448268;6255.093011513396;5986.431289027535;6118.938810612015;6122.418370254819;6160.014397696347;6163.445289923929 10:24:58 INFO - PROCESS | 1642 | |1;ext.html;495.9578435832954;534.4094775273323;541.9647722898011;565.5616896904899;585.0171711524637;38898.805505972465;42115.78942105293;42145.36781948269;42162.578374216246;42315.78842105793;41963;42914.497992570265;43015.56984430155;43535.78232108835;43582.47461338846;9759.121679048883;9794.853077203848;9872.802543949118;9920.751981200492;9972.601095956154;7898.368130549542;9832.655857045005;9844.507774611277;9860.852087218698;9885;9827.852582211273;9865.506724663774;9898.158656514204;9925.652602158925;9995.95002024989;9822.950885245564;9831.65589204378;9886.406815591015;9908.603655853758;9926.702198933972;9760.511974401252;9827.459489728062;9862.50687465631;9877.209823214125;9878.654247101316;40638.39042414366;41027.76916692504;41083.7945810269;41198.970025749295;41332;3094.319249765048;3241.1897025743565;3433.2446861690387;3467.2025434150037;3906.277338692351;29985.950491732903;30358.84820575905;31179.59691813851;31714.414279285942;32454.6754532454;3314.867405303785;3346.28054968183;3351.7151042161445;3371.2246183377715;3425.9314813703586;511967;512494;515252;518366;531170;65902.67048664822;66245;66368;66380;66452.66773666101;68284.6585767068;68377;68630;68639.65680171567;68664;16933.238004289837;17236.310547578207;17269.654606908043;17284.04937728412;17427.91286043587;10919.235653504178;13372.531961381304;13392.196468211743;13405.731885362238;13422.261775602241;16394.83605163957;19305.80694193068;19480;19498.830070195832;19518.316858910155;6711.328867113347;7734.574598397142;7813.320136170637;7944.84110317802;7971.362291016705;859.737779977113;1001.249063202598;1042.2756184451885;1093.2019625673304;1105.5025238642481;30864.38271234563;30913.227169320948;31021.379572408427;31244.687553124633;31284.53073203904;1064.3768253413452;1066.7599790047177;1070.3791800755544;1096.9085759669022;1127.7575321305958;12679.492820287269;15533.068015919082;16034.438794642132;16042.839571604134;16191.433299834449;679913;685269;687357;688593;688683.6697449542;61217.693911531045;61739;61881;61901.690491547255;61960.69019654873;1227.969300767488;1354.8238728965368;1386.7850483175123;1402.4670625162578;1418.758586237022;23552.411189720395;30040.549391758705;30915.536266956464;31035.689643104182;31284.37431251408;51923;52272.738636306574;52279.21581176361;52318.73840630925;52452.47547524476;498571;500303;500429;501732;501958;27037.053703120295;27391.17826465209;27474;27709.168724938285;27829.582556261266;47760.522394777;48391;48769.756151219015;49571.752141240504;49727;39600;39875.800620996706;40209;40790;41520;39506.209875802895;39743.40384894171;40098.79950600345;40833;40845.978850528976;38827.61172388353;39029.80485097556;39772.20455590814;39875.2024959505;41417;26465;29499;30422;31495.37009259756;33190.834045829615;24984.875075624506;25627;26690.733092668826;26800;26873.193804185907 10:24:58 INFO - PROCESS | 1642 | |2;jquery.html;335.24067986011687;390.61524398467515;397.5209872104115;400.203594846256;414.43429718434345;19315.420537383867;20142;20243.190272389103;20666.793332066674;20748.962551872384;17626.823731762677;17830.465086047407;17843.821561784378;20802.47993800152;20928.95355232236;5442.564594832404;5593.720313984305;5914.053751399777;6010.789622363218;6082.087686846964;6020.337762846106;6027.186329845458;6124.203853499062;6134.202553668017;6134.4478996890275;5787.971060144714;5958.791442299499;5999.340072592011;5999.340072592011;6095.756169753205;5762.9135562966585;5980.73086711099;5998.340182579891;6005.849853753647;6077.78727744529;5183.377994640629;5210.843674689765;5269.789208431658;5308.575313974911;5310.070737620901;25350.239492815246;25668.71656417172;25677.871610642014;25835;25928.8703556481;2427.2596857958315;2481.5285095831914;2911.170316459799;3166.2717574957887;3189.39401513714;15404.614884627861;15440.45958391451;15643;16085.597860053475;16338.918305408515;1887.9899253899234;1925.9614807703908;1958.265650381107;1978.2482656590403;1979.2281010405952;84950.57524712398;92523;102461.97538024673;113060.30409543781;121194.39402803018;11248.156388270912;11572.942135289439;11740.178187526792;11764.470598822902;11901.70245743846;12078.154529182873;12767.872321276855;14281.42874285017;14382.784258236135;14589.927050364893;7396.038514993016;8901.643934242558;8929.553522323858;8934.687285944961;9056.184943354998;7279.745208917662;8908.643654253758;8964.327675424369;9076.8638470423;9098.317626178063;7001.36987671112;7051.1186101737285;7079.36285734276;7099.680514376865;7118.9644051779405;1950.9219631214592;1952.5997170579997;1956.8336691381107;1961.6174845904911;1968.2815772243027;743;994.7363948553639;1029.1920842138884;1044.6187141693226;1082.9891701083045;20384;22972.966216520297;23151.189708360125;23254.76745232526;23389.41526461852;895.417978314088;927.9443233406017;939.2342396294922;941.7615835176857;995.7659949911765;9482.668106616373;9506.47714375716;11510.59712910044;11596.246243994114;11625.941870290595;615424;622722;628370;630475;634118;116116;132826.67173328335;137099;142196;148168;1046.5186014433293;1050.5115121468555;1071.5927947379946;1087.749817541954;1109.7336639206533;18997.43007709771;19752.802471975097;20100;20177.39467815968;20286;43132;51913.702157446365;57173.85652287014;58822.411775881694;59423.40576594179;70901;71802.28197717956;73573;80891;81871.49706766185;7149.320814522612;7557.5465472071855;7906.367490600623;8179.918200817916;8195.754127376189;12362.134650574373;12548;12700.110992230824;12782.552610658582;12970.156939798882;9207;10757.623483178364;11060.834087488854;11341;11480.540778368771;10811;10844.403557804397;10882.401467919024;11074.5570177192;11231;11180.944095279472;11190.384528850991;11363;11429.942850285695;11858.525658973544;7395.482316237812;7572.659230334758;7590.392768578611;7649.31156195945;7733.690652373842;10687.786244274916;11214.439278035903;11265.26775759573;11376.033037191932;11513.597024104116 10:24:58 INFO - PROCESS | 1642 | |3;mootools.html;1496.0724350902442;1523.8933274670774;1735.3058776489402;1809.5566586186387;1884.3498992847462;7724.652390642421;7955.244251796084;8173.182681731824;8660.956695216522;8761.780955476117;7742.612869356523;7909.24862138096;8181.222783835541;8543.35924805639;8559.186877246668;2363.751806060369;2405.1581946318825;2408.446057406789;2413.1795189635523;2415.891284892184;2398.6162214045758;2400.8079353651665;2432.914847980321;2433.051110067075;2481.801455883525;2395.4849707312924;2395.6167013277877;2400.3519049856613;2407.4944261704977;2415.0581273303424;2362.787349138577;2369.3010561884284;2383.4994651123284;2392.4856155926386;2401.6757737705448;2397.041183526586;2398.952020959571;2415.8188135889877;2430.4409985703387;2431.0275889644286;8406.663733450716;8511.10633383492;8578.69974550894;8586.31309495239;8603.827923441497;5019.196928491424;5155.871103222412;5160.690358578459;5184.326037615086;5190.377154741455;3322.6677332266822;3374.8818791342187;3384.3738908302043;3505.789652620851;3606.549181352331;930.3487558708863;1085.918556108295;1093.6882988348361;1120.9495572699248;1128.0637071230858;10947.890521094767;11016.228863979524;11074.446277686164;11115.499802508906;11116.610918617891;4602.585767280961;4741.857744267678;4797.5682188602495;4810.182269014276;4835.903281934342;8346.791330216673;9529.809403811885;9562.426254424618;9669.564869580885;9672.419654820733;5311.336082989626;5334.359876814729;5373.140297552372;5385.407605163429;5388.137897936312;4431;4474.664400170001;4863.294822250754;4923.77842997066;4944.381952255968;3305.289362787012;3946.940795888064;4000.699947503949;4100.5899410059355;4111.424400583921;1302.6613080599113;1325.8541560428346;1344.2069179184327;1350.1831392007891;1351.8850897673808;820.7332616899531;858.0947100808706;888.5690440136528;947.4552132523827;958.3866325551653;5665.5467562594895;5717.313922329264;5736.368999410145;5785.652860828363;5935.080062590306;882.1178821178821;928.4986107502008;967.8644989701447;1009.6819501856892;1043.2332235806675;2944.8822047118306;3826.693864490834;3905.964919296389;3920.196359746245;3956.2878681837547;9938.701838944844;10218.846717299246;10226.590936362461;10274.589016439259;10276.486175691185;10129.746756331151;10180.694579162637;10240;10244.53899574521;10261.230407719451;7540.019797426409;7755.030621172354;7938.325242354349;7944.285014348737;7980.082290536547;5682.9147562785765;5741.655500669973;5858.853528661817;5941.67320797343;5954.315253745702;9021.188093071654;9159.267258619162;9409.811803763749;9506.382085164441;9536.380135291183;9169;9341.392809467363;9473.715788526355;9544.665936692183;9621.27840411986;6734.158230221223;6847.041414202115;7052.894206587008;7159.284071592799;7273.599952002691;7801;7959.124496305286;8044.879326809985;8069.59652017385;8095.109537950703;7120;7158.355747982707;7285.817854553678;7321.78034658961;7372.373348265458;7027.121609798775;7215.530990485601;7220;7231.2768723127265;7315.48791584584;6708.530402871752;6869.484788640772;6879.449644028366;6886.139232595926;6893.7931862044215;4864.562189402971;4912.410510738591;5020.548150666312;5049.722265275445;5071.188609822559;4925.605951523941;4952.752362381794;5009.774560144875;5030.698158110525;5044.8991020178655 10:24:58 INFO - PROCESS | 1642 | |4;prototype.html;302.63834717512583;312.17585574084416;317.42387566566686;322.1704111911828;324.5278120334913;5111.361079865017;5294.391145018324;5450.918236226455;5485.314335708036;5536.532818803021;5369.114096174127;5471.753771080301;5476.17857321401;5499.422560631137;5516.207232649395;4240.957590424095;4244.40578319034;4262.957370426287;4277.8074986625525;4281.978590107061;3988.4814974053334;4271.188474189894;4277.850275240367;4285.142971405716;4295.024288827143;3494.178867966026;4148.8340466381305;4175.478065241845;4231.365295205713;4232.984083819876;3533.522974398462;3703.333399988001;3865.342891708416;4175.916481670365;4228.266410771569;3681.9933136440704;3682.558093028854;3694.371956767356;3711.4803927449907;3715.38380804351;5049.368828896388;5126.61550383719;5315.335583052119;5316.41519432866;5365.195220716884;4243.448351714288;4784.067106914154;4824.975875120637;4832.130216561018;4841.298011788306;4637.330560998038;5782.715827248256;5819.941800582024;5826.329972053226;5872.354041055481;3793.5827059023486;4038.757674539537;4072.226277007359;4085.2238074765996;4103.630673239423;4716.693414928053;5802.535797136219;6032.215811944463;6032.969835150884;6051;3194.456942319765;3856.421536769451;3907.667848232932;3909.2213043065335;3936.602506110347;3993.0616305168264;4001.5998400160333;4021.356582946773;4035.051762835731;4047.615476529725;4363.47638283408;4667.229907065296;4670.719756814534;4672.135654903854;4712.363830882856;4655.231886738718;5308.283381743492;5814.738336774855;5832.62087964281;5864.472197502245;1216.8235605837103;1240.4232032105115;1366.706158175997;1380.9654758631114;1387.653086728318;897.8955884262264;951.9671156794955;952.9327153588026;953.8712273843081;964.8263312603658;5215.913634546212;5303.443138470482;5309.628326017141;5314.601404894648;5382.973085134628;4928.383952005999;5247.685138891678;5668.234788303609;5703.69000554776;5716.684323092596;4210.536840947493;4824.734639594786;4959.330490383752;5022;5216.947830521646;2702.662167229096;2960.6676995352177;2968.836713980752;2969.4061187762536;2989.611350524418;5464.562834973192;5618.033688209094;5765.798197063083;5854.619449735754;5877.796600852545;5070.569001634829;5209.453007434165;5714.571407144481;6118.388161183846;6138.539609529304;5427.755750991215;5613.803516876889;5678.432156784289;6230.750769969241;6237.313895471494;5441.319835020622;5695;5784.363719990882;6005.489533389711;6018.699065046818;5884.735186916685;5888.882222355614;5894.410558944071;5895.67573783446;5917.260342457193;4597.70114942541;4916.852494425173;5187.818426355059;5856.344206356042;6228;3763.2661630981697;4008.518977722692;4018.5378681452007;4018.9598104018587;4027.9527322896843;5089.6691715038405;5971.611845230046;5990.723525060449;6006.399360063959;6031.73809821317;4695.342652028787;5560.777568897361;5703.258576385209;5868.735906884286;5918.6029657986865;5289.170293892749;5482.956958887856;5718.742656580547;5762.913556296575;5822.854428639318;4780.139574876555;4794.986105835487;5673.631213971079;5716.256197025368;5724.542036636975;4795.496472870298;5417.916416716751;5797.072468405035;5841.561882858718;5849.888521180962;4990.051890140861;5609.326880774333;5725.570582206435;5746.896675795191;5757.222774925332 10:24:58 INFO - PROCESS | 1642 | |5;yui.html;709.8083517450289;738.47937204271;757.0839284465796;776.8485145396646;800.8838718385831;15132.546023619296;15577.532674019769;15711;15739.842601573995;15769.448069317561;13037;13130.277834719087;13181.60455186346;13231.338433078332;13297.800532991989;842.4145219072747;846.2552953400999;859.9269062129711;879.4547380624022;879.7624641346832;867.5402036920442;869.1873098652749;875.7547886591765;878.5826732302137;878.9165029322204;882.4396508217296;886.685226744506;912.3795818843184;920.0845159066738;921;869.8216865542548;870.4168207301124;874.5670892907988;876.8947726272856;908.259768288849;664.3821246240994;681.495693187043;686.7664993902097;687.542784048612;688.7417218543046;12897.742045159044;12954.676133096653;13098.410571524304;13192.274424906625;13537.86462135376;11924.95986363549;11933.462994165197;11966.102542309362;12030;12157.574484892986;9625.326227164102;10844.186685998582;11070;11083.944580277128;11552.942235288854;4500.954990450086;4560.384348112995;4593.977030114861;4607.35497030416;4618.884527886829;66148.00777988334;70726.64636676783;87856.12143878607;92237.53881230619;97663;10904.836427453594;10914.836277455845;10991.175661825395;11053.723656908642;11261.099112071015;20412.693809592867;20441.977901104885;20547.794522054886;20658.79341206599;20734.274300399717;7584.4311676624475;7711.652975616111;7913.485623434458;8136.064352599408;8160.918390816016;4437.64498840092;4462.397576327155;4574.908501830011;4584.129015487047;4662.160811054043;3418.9487157692656;3474.722022238215;3493.6681015304016;3541.327147841902;3541.681248687579;658.7430901948148;659.5548005096541;662.1888186970922;665.6239224837951;673.8483841135705;582.967936763482;600.5465873265656;621.4220774679501;691.8789211888001;697.7034760226985;9058.954705226564;9507.619695212252;9615.5672994714;9620.086091821266;9690.95154524237;621.4375989729302;655.757369773187;674.7537148940602;682.2358957967109;691.3190507350256;3503.8072905989907;4438.800253988578;4460.7323560586465;4625.283081122431;4771.403574553181;87599.56200218959;87762.56118719366;88777;88865.55567222252;91814;53656.73171634117;63584.68207658932;69246;73138;95126.5243673791;83663;86437;87573;88122;89945;9684.70945871625;9772.413655180711;10030.64892728751;10046.346987445793;10089.394636321844;36783.44824827576;53156.46843531515;56352.87294254174;56969.715151423974;57670.55823604443;76047.61976190304;79329.60335198518;80246.5987670058;81717;82239.17760822315;12239;12659.050571207381;12697.8095328572;12882.806757898827;12939.935300323437;13991.510297139552;14220.502282420066;14242.643933901321;14662.63343416423;14797.260136993322;12819.230846149261;13306;13535.458581656623;13635.522756703864;14089.013769036479;10959.397233151934;13168.539101131415;13247.470101195844;13776.448942042207;14051.156930584199;12814.807777883525;13140.474381025035;13189.868101318863;13262.27057511846;13662.658433539242;11196.440177991231;11407.828882566933;11575.710607234887;11706.824397633873;11845.526178952745;11303;11371.327737981734;11445.48495317696;11539.019183369508;11540.307581545134 10:24:58 INFO - PROCESS | 1642 | __end_tp_report 10:24:58 INFO - PROCESS | 1642 | __start_cc_report 10:24:58 INFO - PROCESS | 1642 | _x_x_mozilla_cycle_collect,357 10:24:58 INFO - PROCESS | 1642 | __end_cc_report 10:24:58 INFO - PROCESS | 1642 | __startTimestamp1486146298546__endTimestamp 10:24:58 INFO - PROCESS | 1642 | 10:24:58 INFO - PROCESS | 1642 | ------- Summary: start ------- 10:24:58 INFO - PROCESS | 1642 | Number of tests: 6 10:24:58 INFO - PROCESS | 1642 | 10:24:58 INFO - PROCESS | 1642 | [#0] dojo.html Cycles:165 Average:5834.44 Median:6087.31 stddev:627.91 (10.3%) stddev-sans-first:603.48 10:24:58 INFO - PROCESS | 1642 | Values: 3539.6 3540.3 3559.6 3568.3 3594.3 5848.1 5881.6 5905.2 5924.7 5936.2 5902.5 5977.4 5984.9 5998.3 6004.1 5070.5 5253.0 5321.1 5366.3 5388.5 5367.9 5404.4 5408.3 5409.8 5419.0 5233.5 5285.2 5400.0 5404.2 5447.8 4451.7 5295.1 5341.0 5364.5 5430.5 5210.4 5308.2 5326.7 5353.6 5377.5 4991.7 5699.0 5830.7 5933.7 5973.9 6161.1 6190.9 6195.1 6199.2 6246.9 6300.8 6322.2 6322.3 6336.6 6405.8 5235.3 6027.5 6047.0 6068.8 6087.3 6194.1 6270.9 6283.0 6342.4 6391.6 6210.3 6219.6 6244.5 6274.4 6294.9 6280.2 6295.5 6309.0 6321.9 6328.0 6178.3 6210.4 6211.2 6222.1 6292.1 6226.4 6241.4 6249.8 6259.7 6283.4 5040.4 5043.4 5055.7 5078.3 5078.5 4434.8 4437.6 4461.8 4551.1 4561.8 5872.4 5919.5 5952.1 6034.2 6079.8 5918.0 6014.1 6286.7 6305.9 6322.0 5769.7 5884.4 5892.6 5934.1 5951.3 5529.1 5534.8 5536.1 5544.6 5552.2 6449.6 6507.8 6508.6 6509.3 6520.7 6135.0 6169.5 6201.2 6209.5 6291.9 6434.4 6448.3 6459.0 6463.3 6475.7 5216.8 6256.0 6260.4 6263.3 6284.4 6145.5 6238.9 6241.9 6255.3 6264.7 5383.8 6113.4 6129.2 6233.8 6255.2 6160.1 6196.8 6199.4 6241.1 6257.9 5989.3 6002.3 6068.2 6108.1 6115.7 6112.6 6128.3 6143.0 6235.6 6255.1 5986.4 6118.9 6122.4 6160.0 6163.4 10:24:58 INFO - PROCESS | 1642 | 10:24:58 INFO - PROCESS | 1642 | [#1] ext.html Cycles:180 Average:70975.72 Median:41141.38 stddev:153444.72 (373.0%) stddev-sans-first:153783.93 10:24:58 INFO - PROCESS | 1642 | Values: 496.0 534.4 542.0 565.6 585.0 38898.8 42115.8 42145.4 42162.6 42315.8 41963.0 42914.5 43015.6 43535.8 43582.5 9759.1 9794.9 9872.8 9920.8 9972.6 7898.4 9832.7 9844.5 9860.9 9885.0 9827.9 9865.5 9898.2 9925.7 9996.0 9823.0 9831.7 9886.4 9908.6 9926.7 9760.5 9827.5 9862.5 9877.2 9878.7 40638.4 41027.8 41083.8 41199.0 41332.0 3094.3 3241.2 3433.2 3467.2 3906.3 29986.0 30358.8 31179.6 31714.4 32454.7 3314.9 3346.3 3351.7 3371.2 3425.9 511967.0 512494.0 515252.0 518366.0 531170.0 65902.7 66245.0 66368.0 66380.0 66452.7 68284.7 68377.0 68630.0 68639.7 68664.0 16933.2 17236.3 17269.7 17284.0 17427.9 10919.2 13372.5 13392.2 13405.7 13422.3 16394.8 19305.8 19480.0 19498.8 19518.3 6711.3 7734.6 7813.3 7944.8 7971.4 859.7 1001.2 1042.3 1093.2 1105.5 30864.4 30913.2 31021.4 31244.7 31284.5 1064.4 1066.8 1070.4 1096.9 1127.8 12679.5 15533.1 16034.4 16042.8 16191.4 679913.0 685269.0 687357.0 688593.0 688683.7 61217.7 61739.0 61881.0 61901.7 61960.7 1228.0 1354.8 1386.8 1402.5 1418.8 23552.4 30040.5 30915.5 31035.7 31284.4 51923.0 52272.7 52279.2 52318.7 52452.5 498571.0 500303.0 500429.0 501732.0 501958.0 27037.1 27391.2 27474.0 27709.2 27829.6 47760.5 48391.0 48769.8 49571.8 49727.0 39600.0 39875.8 40209.0 40790.0 41520.0 39506.2 39743.4 40098.8 40833.0 40846.0 38827.6 39029.8 39772.2 39875.2 41417.0 26465.0 29499.0 30422.0 31495.4 33190.8 24984.9 25627.0 26690.7 26800.0 26873.2 10:24:58 INFO - PROCESS | 1642 | 10:24:58 INFO - PROCESS | 1642 | [#2] jquery.html Cycles:180 Average:35817.97 Median:25509.48 stddev:104119.26 (408.2%) stddev-sans-first:104377.25 10:24:58 INFO - PROCESS | 1642 | Values: 335.2 390.6 397.5 400.2 414.4 19315.4 20142.0 20243.2 20666.8 20749.0 17626.8 17830.5 17843.8 20802.5 20929.0 5442.6 5593.7 5914.1 6010.8 6082.1 6020.3 6027.2 6124.2 6134.2 6134.4 5788.0 5958.8 5999.3 5999.3 6095.8 5762.9 5980.7 5998.3 6005.8 6077.8 5183.4 5210.8 5269.8 5308.6 5310.1 25350.2 25668.7 25677.9 25835.0 25928.9 2427.3 2481.5 2911.2 3166.3 3189.4 15404.6 15440.5 15643.0 16085.6 16338.9 1888.0 1926.0 1958.3 1978.2 1979.2 84950.6 92523.0 102462.0 113060.3 121194.4 11248.2 11572.9 11740.2 11764.5 11901.7 12078.2 12767.9 14281.4 14382.8 14589.9 7396.0 8901.6 8929.6 8934.7 9056.2 7279.7 8908.6 8964.3 9076.9 9098.3 7001.4 7051.1 7079.4 7099.7 7119.0 1950.9 1952.6 1956.8 1961.6 1968.3 743.0 994.7 1029.2 1044.6 1083.0 20384.0 22973.0 23151.2 23254.8 23389.4 895.4 927.9 939.2 941.8 995.8 9482.7 9506.5 11510.6 11596.2 11625.9 615424.0 622722.0 628370.0 630475.0 634118.0 116116.0 132826.7 137099.0 142196.0 148168.0 1046.5 1050.5 1071.6 1087.7 1109.7 18997.4 19752.8 20100.0 20177.4 20286.0 43132.0 51913.7 57173.9 58822.4 59423.4 70901.0 71802.3 73573.0 80891.0 81871.5 7149.3 7557.5 7906.4 8179.9 8195.8 12362.1 12548.0 12700.1 12782.6 12970.2 9207.0 10757.6 11060.8 11341.0 11480.5 10811.0 10844.4 10882.4 11074.6 11231.0 11180.9 11190.4 11363.0 11429.9 11858.5 7395.5 7572.7 7590.4 7649.3 7733.7 10687.8 11214.4 11265.3 11376.0 11513.6 10:24:58 INFO - PROCESS | 1642 | 10:24:58 INFO - PROCESS | 1642 | [#3] mootools.html Cycles:180 Average:5535.58 Median:5113.53 stddev:2989.40 (58.5%) stddev-sans-first:2982.37 10:24:58 INFO - PROCESS | 1642 | Values: 1496.1 1523.9 1735.3 1809.6 1884.3 7724.7 7955.2 8173.2 8661.0 8761.8 7742.6 7909.2 8181.2 8543.4 8559.2 2363.8 2405.2 2408.4 2413.2 2415.9 2398.6 2400.8 2432.9 2433.1 2481.8 2395.5 2395.6 2400.4 2407.5 2415.1 2362.8 2369.3 2383.5 2392.5 2401.7 2397.0 2399.0 2415.8 2430.4 2431.0 8406.7 8511.1 8578.7 8586.3 8603.8 5019.2 5155.9 5160.7 5184.3 5190.4 3322.7 3374.9 3384.4 3505.8 3606.5 930.3 1085.9 1093.7 1120.9 1128.1 10947.9 11016.2 11074.4 11115.5 11116.6 4602.6 4741.9 4797.6 4810.2 4835.9 8346.8 9529.8 9562.4 9669.6 9672.4 5311.3 5334.4 5373.1 5385.4 5388.1 4431.0 4474.7 4863.3 4923.8 4944.4 3305.3 3946.9 4000.7 4100.6 4111.4 1302.7 1325.9 1344.2 1350.2 1351.9 820.7 858.1 888.6 947.5 958.4 5665.5 5717.3 5736.4 5785.7 5935.1 882.1 928.5 967.9 1009.7 1043.2 2944.9 3826.7 3906.0 3920.2 3956.3 9938.7 10218.8 10226.6 10274.6 10276.5 10129.7 10180.7 10240.0 10244.5 10261.2 7540.0 7755.0 7938.3 7944.3 7980.1 5682.9 5741.7 5858.9 5941.7 5954.3 9021.2 9159.3 9409.8 9506.4 9536.4 9169.0 9341.4 9473.7 9544.7 9621.3 6734.2 6847.0 7052.9 7159.3 7273.6 7801.0 7959.1 8044.9 8069.6 8095.1 7120.0 7158.4 7285.8 7321.8 7372.4 7027.1 7215.5 7220.0 7231.3 7315.5 6708.5 6869.5 6879.4 6886.1 6893.8 4864.6 4912.4 5020.5 5049.7 5071.2 4925.6 4952.8 5009.8 5030.7 5044.9 10:24:58 INFO - PROCESS | 1642 | 10:24:58 INFO - PROCESS | 1642 | [#4] prototype.html Cycles:180 Average:4635.87 Median:5198.64 stddev:1410.47 (27.1%) stddev-sans-first:1376.42 10:24:58 INFO - PROCESS | 1642 | Values: 302.6 312.2 317.4 322.2 324.5 5111.4 5294.4 5450.9 5485.3 5536.5 5369.1 5471.8 5476.2 5499.4 5516.2 4241.0 4244.4 4263.0 4277.8 4282.0 3988.5 4271.2 4277.9 4285.1 4295.0 3494.2 4148.8 4175.5 4231.4 4233.0 3533.5 3703.3 3865.3 4175.9 4228.3 3682.0 3682.6 3694.4 3711.5 3715.4 5049.4 5126.6 5315.3 5316.4 5365.2 4243.4 4784.1 4825.0 4832.1 4841.3 4637.3 5782.7 5819.9 5826.3 5872.4 3793.6 4038.8 4072.2 4085.2 4103.6 4716.7 5802.5 6032.2 6033.0 6051.0 3194.5 3856.4 3907.7 3909.2 3936.6 3993.1 4001.6 4021.4 4035.1 4047.6 4363.5 4667.2 4670.7 4672.1 4712.4 4655.2 5308.3 5814.7 5832.6 5864.5 1216.8 1240.4 1366.7 1381.0 1387.7 897.9 952.0 952.9 953.9 964.8 5215.9 5303.4 5309.6 5314.6 5383.0 4928.4 5247.7 5668.2 5703.7 5716.7 4210.5 4824.7 4959.3 5022.0 5216.9 2702.7 2960.7 2968.8 2969.4 2989.6 5464.6 5618.0 5765.8 5854.6 5877.8 5070.6 5209.5 5714.6 6118.4 6138.5 5427.8 5613.8 5678.4 6230.8 6237.3 5441.3 5695.0 5784.4 6005.5 6018.7 5884.7 5888.9 5894.4 5895.7 5917.3 4597.7 4916.9 5187.8 5856.3 6228.0 3763.3 4008.5 4018.5 4019.0 4028.0 5089.7 5971.6 5990.7 6006.4 6031.7 4695.3 5560.8 5703.3 5868.7 5918.6 5289.2 5483.0 5718.7 5762.9 5822.9 4780.1 4795.0 5673.6 5716.3 5724.5 4795.5 5417.9 5797.1 5841.6 5849.9 4990.1 5609.3 5725.6 5746.9 5757.2 10:24:58 INFO - PROCESS | 1642 | 10:24:58 INFO - PROCESS | 1642 | [#5] yui.html Cycles:180 Average:19428.37 Median:4643.72 stddev:27073.43 (583.0%) stddev-sans-first:27112.89 10:24:58 INFO - PROCESS | 1642 | Values: 709.8 738.5 757.1 776.8 800.9 15132.5 15577.5 15711.0 15739.8 15769.4 13037.0 13130.3 13181.6 13231.3 13297.8 842.4 846.3 859.9 879.5 879.8 867.5 869.2 875.8 878.6 878.9 882.4 886.7 912.4 920.1 921.0 869.8 870.4 874.6 876.9 908.3 664.4 681.5 686.8 687.5 688.7 12897.7 12954.7 13098.4 13192.3 13537.9 11925.0 11933.5 11966.1 12030.0 12157.6 9625.3 10844.2 11070.0 11083.9 11552.9 4501.0 4560.4 4594.0 4607.4 4618.9 66148.0 70726.6 87856.1 92237.5 97663.0 10904.8 10914.8 10991.2 11053.7 11261.1 20412.7 20442.0 20547.8 20658.8 20734.3 7584.4 7711.7 7913.5 8136.1 8160.9 4437.6 4462.4 4574.9 4584.1 4662.2 3418.9 3474.7 3493.7 3541.3 3541.7 658.7 659.6 662.2 665.6 673.8 583.0 600.5 621.4 691.9 697.7 9059.0 9507.6 9615.6 9620.1 9691.0 621.4 655.8 674.8 682.2 691.3 3503.8 4438.8 4460.7 4625.3 4771.4 87599.6 87762.6 88777.0 88865.6 91814.0 53656.7 63584.7 69246.0 73138.0 95126.5 83663.0 86437.0 87573.0 88122.0 89945.0 9684.7 9772.4 10030.6 10046.3 10089.4 36783.4 53156.5 56352.9 56969.7 57670.6 76047.6 79329.6 80246.6 81717.0 82239.2 12239.0 12659.1 12697.8 12882.8 12939.9 13991.5 14220.5 14242.6 14662.6 14797.3 12819.2 13306.0 13535.5 13635.5 14089.0 10959.4 13168.5 13247.5 13776.4 14051.2 12814.8 13140.5 13189.9 13262.3 13662.7 11196.4 11407.8 11575.7 11706.8 11845.5 11303.0 11371.3 11445.5 11539.0 11540.3 10:24:58 INFO - PROCESS | 1642 | -------- Summary: end -------- 10:24:58 INFO - PROCESS | 1642 | 10:24:59 INFO - TEST-INFO | 1642: exit 0 10:24:59 INFO - TEST-OK | dromaeo_css | took 1114616ms 10:24:59 INFO - TEST-START | kraken 10:24:59 INFO - operating with platform_type : mac_ 10:24:59 INFO - Initialising browser for kraken test... 10:24:59 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/tmpmg4q1g/profile http://localhost:49249/getInfo.html) 10:25:01 INFO - PROCESS | 1653 | 2017-02-03 10:25:01.688 plugin-container[1655:9917] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8643, name = 'com.apple.tsm.portname' 10:25:01 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:25:01 INFO - PROCESS | 1653 | 2017-02-03 10:25:01.688 plugin-container[1655:9917] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x890b, name = 'com.apple.CFPasteboardClient' 10:25:01 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:25:01 INFO - PROCESS | 1653 | 2017-02-03 10:25:01.688 plugin-container[1655:9917] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:25:01 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 10:25:01 INFO - PROCESS | 1653 | colorDepth:24 10:25:01 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 10:25:01 INFO - PROCESS | 1653 | __metrics 10:25:01 ERROR - PROCESS | 1653 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3197: TypeError: this.tabs is undefined 10:25:02 INFO - TEST-INFO | 1653: exit 0 10:25:02 INFO - Browser initialized. 10:25:02 INFO - Running cycle 1/1 for kraken test... 10:25:02 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/tmpmg4q1g/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:25:04 INFO - PROCESS | 1656 | 2017-02-03 10:25:04.971 plugin-container[1657:10039] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8443, name = 'com.apple.tsm.portname' 10:25:04 INFO - PROCESS | 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:25:04 INFO - PROCESS | 1656 | 2017-02-03 10:25:04.972 plugin-container[1657:10039] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4217, name = 'com.apple.CFPasteboardClient' 10:25:04 INFO - PROCESS | 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:25:04 INFO - PROCESS | 1656 | 2017-02-03 10:25:04.972 plugin-container[1657:10039] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:25:14 INFO - PROCESS | 1656 | RSS: Main: 177364992 10:25:14 INFO - PROCESS | 1656 | 10:25:17 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-beat-detection) 10:25:18 INFO - PROCESS | 1656 | RSS: Main: 190894080 10:25:18 INFO - PROCESS | 1656 | 10:25:20 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-dft) 10:25:21 INFO - PROCESS | 1656 | RSS: Main: 198238208 10:25:21 INFO - PROCESS | 1656 | 10:25:24 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-fft) 10:25:25 INFO - PROCESS | 1656 | RSS: Main: 199995392 10:25:25 INFO - PROCESS | 1656 | 10:25:27 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-oscillator) 10:25:28 INFO - PROCESS | 1656 | RSS: Main: 202698752 10:25:28 INFO - PROCESS | 1656 | 10:25:30 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:25:30 INFO - PROCESS | 1656 | RSS: Main: 203378688 10:25:30 INFO - PROCESS | 1656 | 10:25:33 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-darkroom) 10:25:34 INFO - PROCESS | 1656 | RSS: Main: 207863808 10:25:34 INFO - PROCESS | 1656 | 10:25:37 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-desaturate) 10:25:37 INFO - PROCESS | 1656 | RSS: Main: 207441920 10:25:37 INFO - PROCESS | 1656 | 10:25:40 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49249/tests/kraken/driver.html?testName=json-parse-financial) 10:25:41 INFO - PROCESS | 1656 | RSS: Main: 206921728 10:25:41 INFO - PROCESS | 1656 | 10:25:42 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49249/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:25:43 INFO - PROCESS | 1656 | RSS: Main: 206598144 10:25:43 INFO - PROCESS | 1656 | 10:25:45 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:25:45 INFO - PROCESS | 1656 | RSS: Main: 206721024 10:25:45 INFO - PROCESS | 1656 | 10:25:48 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:25:48 INFO - PROCESS | 1656 | RSS: Main: 206299136 10:25:48 INFO - PROCESS | 1656 | 10:25:51 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:25:52 INFO - PROCESS | 1656 | RSS: Main: 206508032 10:25:52 INFO - PROCESS | 1656 | 10:25:55 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:25:55 INFO - PROCESS | 1656 | RSS: Main: 206651392 10:25:55 INFO - PROCESS | 1656 | 10:25:57 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49249/tests/kraken/driver.html?testName=ai-astar) 10:25:57 INFO - PROCESS | 1656 | RSS: Main: 208613376 10:25:57 INFO - PROCESS | 1656 | 10:25:57 INFO - PROCESS | 1656 | __start_tp_report 10:25:57 INFO - PROCESS | 1656 | _x_x_mozilla_page_load 10:25:57 INFO - PROCESS | 1656 | _x_x_mozilla_page_load_details 10:25:57 INFO - PROCESS | 1656 | |i|pagename|runs| 10:25:57 INFO - PROCESS | 1656 | |0;ai-astar;105;120;116;116;118;116;118;116;116;116 10:25:57 INFO - PROCESS | 1656 | |1;audio-beat-detection;145;110;110;146;111;113;110;95;144;145 10:25:57 INFO - PROCESS | 1656 | |2;audio-dft;200;200;231;284;244;246;223;203;198;199 10:25:57 INFO - PROCESS | 1656 | |3;audio-fft;79;60;61;102;85;83;81;86;93;60 10:25:57 INFO - PROCESS | 1656 | |4;audio-oscillator;86;69;84;74;68;102;119;91;73;85 10:25:57 INFO - PROCESS | 1656 | |5;imaging-gaussian-blur;89;88;94;120;91;89;123;88;90;88 10:25:57 INFO - PROCESS | 1656 | |6;imaging-darkroom;95;97;95;95;96;95;110;97;97;94 10:25:57 INFO - PROCESS | 1656 | |7;imaging-desaturate;89;92;86;85;88;94;99;91;106;132 10:25:57 INFO - PROCESS | 1656 | |8;json-parse-financial;55;55;54;56;58;60;60;59;59;59 10:25:57 INFO - PROCESS | 1656 | |9;json-stringify-tinderbox;67;68;71;77;75;71;69;71;69;70 10:25:57 INFO - PROCESS | 1656 | |10;stanford-crypto-aes;94;90;77;73;84;79;101;103;106;103 10:25:57 INFO - PROCESS | 1656 | |11;stanford-crypto-ccm;152;162;153;137;140;142;140;144;179;136 10:25:57 INFO - PROCESS | 1656 | |12;stanford-crypto-pbkdf2;163;166;161;165;167;186;230;192;168;166 10:25:57 INFO - PROCESS | 1656 | |13;stanford-crypto-sha256-iterative;70;72;75;86;87;60;78;87;87;86 10:25:57 INFO - PROCESS | 1656 | __end_tp_report 10:25:57 INFO - PROCESS | 1656 | __start_cc_report 10:25:57 INFO - PROCESS | 1656 | _x_x_mozilla_cycle_collect,907 10:25:57 INFO - PROCESS | 1656 | __end_cc_report 10:25:57 INFO - PROCESS | 1656 | __startTimestamp1486146357945__endTimestamp 10:25:57 INFO - PROCESS | 1656 | 10:25:57 INFO - PROCESS | 1656 | ------- Summary: start ------- 10:25:57 INFO - PROCESS | 1656 | Number of tests: 14 10:25:57 INFO - PROCESS | 1656 | 10:25:57 INFO - PROCESS | 1656 | [#0] ai-astar Cycles:10 Average:115.70 Median:116.00 stddev:4.00 (3.4%) stddev-sans-first:1.45 10:25:57 INFO - PROCESS | 1656 | Values: 105.0 120.0 116.0 116.0 118.0 116.0 118.0 116.0 116.0 116.0 10:25:57 INFO - PROCESS | 1656 | 10:25:57 INFO - PROCESS | 1656 | [#1] audio-beat-detection Cycles:10 Average:122.90 Median:144.50 stddev:19.64 (13.6%) stddev-sans-first:19.14 10:25:57 INFO - PROCESS | 1656 | Values: 145.0 110.0 110.0 146.0 111.0 113.0 110.0 95.0 144.0 145.0 10:25:57 INFO - PROCESS | 1656 | 10:25:57 INFO - PROCESS | 1656 | [#2] audio-dft Cycles:10 Average:222.80 Median:227.00 stddev:28.70 (12.6%) stddev-sans-first:29.23 10:25:57 INFO - PROCESS | 1656 | Values: 200.0 200.0 231.0 284.0 244.0 246.0 223.0 203.0 198.0 199.0 10:25:57 INFO - PROCESS | 1656 | 10:25:57 INFO - PROCESS | 1656 | [#3] audio-fft Cycles:10 Average:79.00 Median:82.00 stddev:14.44 (17.6%) stddev-sans-first:15.31 10:25:57 INFO - PROCESS | 1656 | Values: 79.0 60.0 61.0 102.0 85.0 83.0 81.0 86.0 93.0 60.0 10:25:57 INFO - PROCESS | 1656 | 10:25:57 INFO - PROCESS | 1656 | [#4] audio-oscillator Cycles:10 Average:85.10 Median:79.00 stddev:15.96 (20.2%) stddev-sans-first:16.93 10:25:57 INFO - PROCESS | 1656 | Values: 86.0 69.0 84.0 74.0 68.0 102.0 119.0 91.0 73.0 85.0 10:25:57 INFO - PROCESS | 1656 | 10:25:57 INFO - PROCESS | 1656 | [#5] imaging-gaussian-blur Cycles:10 Average:96.00 Median:89.00 stddev:13.58 (15.3%) stddev-sans-first:14.17 10:25:57 INFO - PROCESS | 1656 | Values: 89.0 88.0 94.0 120.0 91.0 89.0 123.0 88.0 90.0 88.0 10:25:57 INFO - PROCESS | 1656 | 10:25:57 INFO - PROCESS | 1656 | [#6] imaging-darkroom Cycles:10 Average:97.10 Median:95.50 stddev:4.65 (4.9%) stddev-sans-first:4.87 10:25:57 INFO - PROCESS | 1656 | Values: 95.0 97.0 95.0 95.0 96.0 95.0 110.0 97.0 97.0 94.0 10:25:57 INFO - PROCESS | 1656 | 10:25:57 INFO - PROCESS | 1656 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:90.00 stddev:14.08 (15.6%) stddev-sans-first:14.69 10:25:57 INFO - PROCESS | 1656 | Values: 89.0 92.0 86.0 85.0 88.0 94.0 99.0 91.0 106.0 132.0 10:25:57 INFO - PROCESS | 1656 | 10:25:57 INFO - PROCESS | 1656 | [#8] json-parse-financial Cycles:10 Average:57.50 Median:59.00 stddev:2.27 (3.9%) stddev-sans-first:2.22 10:25:57 INFO - PROCESS | 1656 | Values: 55.0 55.0 54.0 56.0 58.0 60.0 60.0 59.0 59.0 59.0 10:25:57 INFO - PROCESS | 1656 | 10:25:57 INFO - PROCESS | 1656 | [#9] json-stringify-tinderbox Cycles:10 Average:70.80 Median:71.00 stddev:3.08 (4.3%) stddev-sans-first:2.95 10:25:57 INFO - PROCESS | 1656 | Values: 67.0 68.0 71.0 77.0 75.0 71.0 69.0 71.0 69.0 70.0 10:25:57 INFO - PROCESS | 1656 | 10:25:57 INFO - PROCESS | 1656 | [#10] stanford-crypto-aes Cycles:10 Average:91.00 Median:78.00 stddev:12.18 (15.6%) stddev-sans-first:12.87 10:25:57 INFO - PROCESS | 1656 | Values: 94.0 90.0 77.0 73.0 84.0 79.0 101.0 103.0 106.0 103.0 10:25:57 INFO - PROCESS | 1656 | 10:25:57 INFO - PROCESS | 1656 | [#11] stanford-crypto-ccm Cycles:10 Average:148.50 Median:148.00 stddev:13.50 (9.1%) stddev-sans-first:14.26 10:25:57 INFO - PROCESS | 1656 | Values: 152.0 162.0 153.0 137.0 140.0 142.0 140.0 144.0 179.0 136.0 10:25:57 INFO - PROCESS | 1656 | 10:25:57 INFO - PROCESS | 1656 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.40 Median:167.50 stddev:21.42 (12.8%) stddev-sans-first:22.17 10:25:57 INFO - PROCESS | 1656 | Values: 163.0 166.0 161.0 165.0 167.0 186.0 230.0 192.0 168.0 166.0 10:25:57 INFO - PROCESS | 1656 | 10:25:57 INFO - PROCESS | 1656 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.80 Median:86.00 stddev:9.41 (10.9%) stddev-sans-first:9.43 10:25:57 INFO - PROCESS | 1656 | Values: 70.0 72.0 75.0 86.0 87.0 60.0 78.0 87.0 87.0 86.0 10:25:57 INFO - PROCESS | 1656 | -------- Summary: end -------- 10:25:57 INFO - PROCESS | 1656 | 10:25:59 INFO - TEST-INFO | 1656: exit 0 10:25:59 INFO - TEST-OK | kraken | took 59912ms 10:25:59 INFO - SUITE-END | took 1174s 10:25:59 INFO - Completed test suite (00:19:34) 10:25:59 INFO - javascript benchmark 10:25:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7397.908138473181, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3539.5929468111167, 3540.3450361683076, 3559.6084430712617, 3568.33985712643, 3594.2991116732233, 5848.093545500449, 5881.558883083764, 5905.173275741395, 5924.703764811764, 5936.228290322252, 5902.498287645555, 5977.372375900533, 5984.940150598503, 5998.310194327653, 6004.099385092239, 5070.543651071403, 5252.973735131319, 5321.095413779647, 5366.302380690505, 5388.541973932201, 5367.865803354928, 5404.432534583871, 5408.296921400212, 5409.756560954746, 5418.972905135469, 5233.476652334774, 5285.180796976456, 5400.0, 5404.162354834987, 5447.782088716446, 4451.710638808499, 5295.126304159809, 5341.0, 5364.544013758796, 5430.538404235605, 5210.426853046162, 5308.230306605559, 5326.7070311132875, 5353.57171426285, 5377.489138531833, 4991.650584459089, 5698.971505142489, 5830.737616807211, 5933.703314834241, 5973.910391344133, 6161.137440758297, 6190.89509566745, 6195.0707393890825, 6199.194104766351, 6246.906296405557, 6300.842478938017, 6322.209723784527, 6322.336154703736, 6336.588121772116, 6405.7757978471, 5235.319408476912, 6027.517798576191, 6047.0, 6068.75724971005, 6087.308366677171, 6194.0708893665405, 6270.905936410957, 6283.02613094971, 6342.365763423621, 6391.648459334689, 6210.31686514483, 6219.626822390671, 6244.531660125509, 6274.435300822948, 6294.874102517924, 6280.152179455807, 6295.527835412362, 6309.022101574264, 6321.936780632227, 6327.987521996551, 6178.320384757673, 6210.441060304594, 6211.192544969215, 6222.066689996536, 6292.056191571301, 6226.40849119342, 6241.438270555581, 6249.78125765596, 6259.655718935411, 6283.434490895841, 5040.420351659533, 5043.420006699203, 5055.7219352935945, 5078.314427552307, 5078.5175408336145, 4434.800433980478, 4437.600615944581, 4461.843835465808, 4551.089782043538, 4561.840335588238, 5872.412758724179, 5919.496842768327, 5952.077427998667, 6034.1853849730605, 6079.756809727562, 5918.0, 6014.0678194879865, 6286.748530058747, 6305.905411418832, 6322.0200868865395, 5769.68266745333, 5884.382139875337, 5892.616979896293, 5934.080217566284, 5951.345352011275, 5529.115341545414, 5534.75093620788, 5536.058869992111, 5544.584156188222, 5552.194931734876, 6449.6130232186215, 6507.837304067436, 6508.609483431104, 6509.349065093642, 6520.706568204348, 6135.018317212141, 6169.5064394849205, 6201.224846894138, 6209.503239740719, 6291.905621415774, 6434.388733070351, 6448.258450278278, 6458.967705161444, 6463.289038205699, 6475.676216189266, 5216.765245564035, 6255.96872015637, 6260.40526150015, 6263.279722831932, 6284.4344009039405, 6145.525073982123, 6238.937610623836, 6241.937580624136, 6255.31191568918, 6264.68676566179, 5383.757730902041, 6113.358097399709, 6129.205975626662, 6233.75064997395, 6255.186825712628, 6160.13758073861, 6196.783112591038, 6199.380061993765, 6241.095041218907, 6257.8748425030335, 5989.251343582052, 6002.279726432856, 6068.241469816273, 6108.144859719731, 6115.663638499926, 6112.5946701277735, 6128.319797384489, 6142.959235178615, 6235.625862448268, 6255.093011513396, 5986.431289027535, 6118.938810612015, 6122.418370254819, 6160.014397696347, 6163.445289923929], "value": 5797.049323884261, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [495.9578435832954, 534.4094775273323, 541.9647722898011, 565.5616896904899, 585.0171711524637, 38898.805505972465, 42115.78942105293, 42145.36781948269, 42162.578374216246, 42315.78842105793, 41963.0, 42914.497992570265, 43015.56984430155, 43535.78232108835, 43582.47461338846, 9759.121679048883, 9794.853077203848, 9872.802543949118, 9920.751981200492, 9972.601095956154, 7898.368130549542, 9832.655857045005, 9844.507774611277, 9860.852087218698, 9885.0, 9827.852582211273, 9865.506724663774, 9898.158656514204, 9925.652602158925, 9995.95002024989, 9822.950885245564, 9831.65589204378, 9886.406815591015, 9908.603655853758, 9926.702198933972, 9760.511974401252, 9827.459489728062, 9862.50687465631, 9877.209823214125, 9878.654247101316, 40638.39042414366, 41027.76916692504, 41083.7945810269, 41198.970025749295, 41332.0, 3094.319249765048, 3241.1897025743565, 3433.2446861690387, 3467.2025434150037, 3906.277338692351, 29985.950491732903, 30358.84820575905, 31179.59691813851, 31714.414279285942, 32454.6754532454, 3314.867405303785, 3346.28054968183, 3351.7151042161445, 3371.2246183377715, 3425.9314813703586, 511967.0, 512494.0, 515252.0, 518366.0, 531170.0, 65902.67048664822, 66245.0, 66368.0, 66380.0, 66452.66773666101, 68284.6585767068, 68377.0, 68630.0, 68639.65680171567, 68664.0, 16933.238004289837, 17236.310547578207, 17269.654606908043, 17284.04937728412, 17427.91286043587, 10919.235653504178, 13372.531961381304, 13392.196468211743, 13405.731885362238, 13422.261775602241, 16394.83605163957, 19305.80694193068, 19480.0, 19498.830070195832, 19518.316858910155, 6711.328867113347, 7734.574598397142, 7813.320136170637, 7944.84110317802, 7971.362291016705, 859.737779977113, 1001.249063202598, 1042.2756184451885, 1093.2019625673304, 1105.5025238642481, 30864.38271234563, 30913.227169320948, 31021.379572408427, 31244.687553124633, 31284.53073203904, 1064.3768253413452, 1066.7599790047177, 1070.3791800755544, 1096.9085759669022, 1127.7575321305958, 12679.492820287269, 15533.068015919082, 16034.438794642132, 16042.839571604134, 16191.433299834449, 679913.0, 685269.0, 687357.0, 688593.0, 688683.6697449542, 61217.693911531045, 61739.0, 61881.0, 61901.690491547255, 61960.69019654873, 1227.969300767488, 1354.8238728965368, 1386.7850483175123, 1402.4670625162578, 1418.758586237022, 23552.411189720395, 30040.549391758705, 30915.536266956464, 31035.689643104182, 31284.37431251408, 51923.0, 52272.738636306574, 52279.21581176361, 52318.73840630925, 52452.47547524476, 498571.0, 500303.0, 500429.0, 501732.0, 501958.0, 27037.053703120295, 27391.17826465209, 27474.0, 27709.168724938285, 27829.582556261266, 47760.522394777, 48391.0, 48769.756151219015, 49571.752141240504, 49727.0, 39600.0, 39875.800620996706, 40209.0, 40790.0, 41520.0, 39506.209875802895, 39743.40384894171, 40098.79950600345, 40833.0, 40845.978850528976, 38827.61172388353, 39029.80485097556, 39772.20455590814, 39875.2024959505, 41417.0, 26465.0, 29499.0, 30422.0, 31495.37009259756, 33190.834045829615, 24984.875075624506, 25627.0, 26690.733092668826, 26800.0, 26873.193804185907], "value": 20458.029544525227, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.24067986011687, 390.61524398467515, 397.5209872104115, 400.203594846256, 414.43429718434345, 19315.420537383867, 20142.0, 20243.190272389103, 20666.793332066674, 20748.962551872384, 17626.823731762677, 17830.465086047407, 17843.821561784378, 20802.47993800152, 20928.95355232236, 5442.564594832404, 5593.720313984305, 5914.053751399777, 6010.789622363218, 6082.087686846964, 6020.337762846106, 6027.186329845458, 6124.203853499062, 6134.202553668017, 6134.4478996890275, 5787.971060144714, 5958.791442299499, 5999.340072592011, 5999.340072592011, 6095.756169753205, 5762.9135562966585, 5980.73086711099, 5998.340182579891, 6005.849853753647, 6077.78727744529, 5183.377994640629, 5210.843674689765, 5269.789208431658, 5308.575313974911, 5310.070737620901, 25350.239492815246, 25668.71656417172, 25677.871610642014, 25835.0, 25928.8703556481, 2427.2596857958315, 2481.5285095831914, 2911.170316459799, 3166.2717574957887, 3189.39401513714, 15404.614884627861, 15440.45958391451, 15643.0, 16085.597860053475, 16338.918305408515, 1887.9899253899234, 1925.9614807703908, 1958.265650381107, 1978.2482656590403, 1979.2281010405952, 84950.57524712398, 92523.0, 102461.97538024673, 113060.30409543781, 121194.39402803018, 11248.156388270912, 11572.942135289439, 11740.178187526792, 11764.470598822902, 11901.70245743846, 12078.154529182873, 12767.872321276855, 14281.42874285017, 14382.784258236135, 14589.927050364893, 7396.038514993016, 8901.643934242558, 8929.553522323858, 8934.687285944961, 9056.184943354998, 7279.745208917662, 8908.643654253758, 8964.327675424369, 9076.8638470423, 9098.317626178063, 7001.36987671112, 7051.1186101737285, 7079.36285734276, 7099.680514376865, 7118.9644051779405, 1950.9219631214592, 1952.5997170579997, 1956.8336691381107, 1961.6174845904911, 1968.2815772243027, 743.0, 994.7363948553639, 1029.1920842138884, 1044.6187141693226, 1082.9891701083045, 20384.0, 22972.966216520297, 23151.189708360125, 23254.76745232526, 23389.41526461852, 895.417978314088, 927.9443233406017, 939.2342396294922, 941.7615835176857, 995.7659949911765, 9482.668106616373, 9506.47714375716, 11510.59712910044, 11596.246243994114, 11625.941870290595, 615424.0, 622722.0, 628370.0, 630475.0, 634118.0, 116116.0, 132826.67173328335, 137099.0, 142196.0, 148168.0, 1046.5186014433293, 1050.5115121468555, 1071.5927947379946, 1087.749817541954, 1109.7336639206533, 18997.43007709771, 19752.802471975097, 20100.0, 20177.39467815968, 20286.0, 43132.0, 51913.702157446365, 57173.85652287014, 58822.411775881694, 59423.40576594179, 70901.0, 71802.28197717956, 73573.0, 80891.0, 81871.49706766185, 7149.320814522612, 7557.5465472071855, 7906.367490600623, 8179.918200817916, 8195.754127376189, 12362.134650574373, 12548.0, 12700.110992230824, 12782.552610658582, 12970.156939798882, 9207.0, 10757.623483178364, 11060.834087488854, 11341.0, 11480.540778368771, 10811.0, 10844.403557804397, 10882.401467919024, 11074.5570177192, 11231.0, 11180.944095279472, 11190.384528850991, 11363.0, 11429.942850285695, 11858.525658973544, 7395.482316237812, 7572.659230334758, 7590.392768578611, 7649.31156195945, 7733.690652373842, 10687.786244274916, 11214.439278035903, 11265.26775759573, 11376.033037191932, 11513.597024104116], "value": 9903.055432757019, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1496.0724350902442, 1523.8933274670774, 1735.3058776489402, 1809.5566586186387, 1884.3498992847462, 7724.652390642421, 7955.244251796084, 8173.182681731824, 8660.956695216522, 8761.780955476117, 7742.612869356523, 7909.24862138096, 8181.222783835541, 8543.35924805639, 8559.186877246668, 2363.751806060369, 2405.1581946318825, 2408.446057406789, 2413.1795189635523, 2415.891284892184, 2398.6162214045758, 2400.8079353651665, 2432.914847980321, 2433.051110067075, 2481.801455883525, 2395.4849707312924, 2395.6167013277877, 2400.3519049856613, 2407.4944261704977, 2415.0581273303424, 2362.787349138577, 2369.3010561884284, 2383.4994651123284, 2392.4856155926386, 2401.6757737705448, 2397.041183526586, 2398.952020959571, 2415.8188135889877, 2430.4409985703387, 2431.0275889644286, 8406.663733450716, 8511.10633383492, 8578.69974550894, 8586.31309495239, 8603.827923441497, 5019.196928491424, 5155.871103222412, 5160.690358578459, 5184.326037615086, 5190.377154741455, 3322.6677332266822, 3374.8818791342187, 3384.3738908302043, 3505.789652620851, 3606.549181352331, 930.3487558708863, 1085.918556108295, 1093.6882988348361, 1120.9495572699248, 1128.0637071230858, 10947.890521094767, 11016.228863979524, 11074.446277686164, 11115.499802508906, 11116.610918617891, 4602.585767280961, 4741.857744267678, 4797.5682188602495, 4810.182269014276, 4835.903281934342, 8346.791330216673, 9529.809403811885, 9562.426254424618, 9669.564869580885, 9672.419654820733, 5311.336082989626, 5334.359876814729, 5373.140297552372, 5385.407605163429, 5388.137897936312, 4431.0, 4474.664400170001, 4863.294822250754, 4923.77842997066, 4944.381952255968, 3305.289362787012, 3946.940795888064, 4000.699947503949, 4100.5899410059355, 4111.424400583921, 1302.6613080599113, 1325.8541560428346, 1344.2069179184327, 1350.1831392007891, 1351.8850897673808, 820.7332616899531, 858.0947100808706, 888.5690440136528, 947.4552132523827, 958.3866325551653, 5665.5467562594895, 5717.313922329264, 5736.368999410145, 5785.652860828363, 5935.080062590306, 882.1178821178821, 928.4986107502008, 967.8644989701447, 1009.6819501856892, 1043.2332235806675, 2944.8822047118306, 3826.693864490834, 3905.964919296389, 3920.196359746245, 3956.2878681837547, 9938.701838944844, 10218.846717299246, 10226.590936362461, 10274.589016439259, 10276.486175691185, 10129.746756331151, 10180.694579162637, 10240.0, 10244.53899574521, 10261.230407719451, 7540.019797426409, 7755.030621172354, 7938.325242354349, 7944.285014348737, 7980.082290536547, 5682.9147562785765, 5741.655500669973, 5858.853528661817, 5941.67320797343, 5954.315253745702, 9021.188093071654, 9159.267258619162, 9409.811803763749, 9506.382085164441, 9536.380135291183, 9169.0, 9341.392809467363, 9473.715788526355, 9544.665936692183, 9621.27840411986, 6734.158230221223, 6847.041414202115, 7052.894206587008, 7159.284071592799, 7273.599952002691, 7801.0, 7959.124496305286, 8044.879326809985, 8069.59652017385, 8095.109537950703, 7120.0, 7158.355747982707, 7285.817854553678, 7321.78034658961, 7372.373348265458, 7027.121609798775, 7215.530990485601, 7220.0, 7231.2768723127265, 7315.48791584584, 6708.530402871752, 6869.484788640772, 6879.449644028366, 6886.139232595926, 6893.7931862044215, 4864.562189402971, 4912.410510738591, 5020.548150666312, 5049.722265275445, 5071.188609822559, 4925.605951523941, 4952.752362381794, 5009.774560144875, 5030.698158110525, 5044.8991020178655], "value": 4516.333884044161, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.63834717512583, 312.17585574084416, 317.42387566566686, 322.1704111911828, 324.5278120334913, 5111.361079865017, 5294.391145018324, 5450.918236226455, 5485.314335708036, 5536.532818803021, 5369.114096174127, 5471.753771080301, 5476.17857321401, 5499.422560631137, 5516.207232649395, 4240.957590424095, 4244.40578319034, 4262.957370426287, 4277.8074986625525, 4281.978590107061, 3988.4814974053334, 4271.188474189894, 4277.850275240367, 4285.142971405716, 4295.024288827143, 3494.178867966026, 4148.8340466381305, 4175.478065241845, 4231.365295205713, 4232.984083819876, 3533.522974398462, 3703.333399988001, 3865.342891708416, 4175.916481670365, 4228.266410771569, 3681.9933136440704, 3682.558093028854, 3694.371956767356, 3711.4803927449907, 3715.38380804351, 5049.368828896388, 5126.61550383719, 5315.335583052119, 5316.41519432866, 5365.195220716884, 4243.448351714288, 4784.067106914154, 4824.975875120637, 4832.130216561018, 4841.298011788306, 4637.330560998038, 5782.715827248256, 5819.941800582024, 5826.329972053226, 5872.354041055481, 3793.5827059023486, 4038.757674539537, 4072.226277007359, 4085.2238074765996, 4103.630673239423, 4716.693414928053, 5802.535797136219, 6032.215811944463, 6032.969835150884, 6051.0, 3194.456942319765, 3856.421536769451, 3907.667848232932, 3909.2213043065335, 3936.602506110347, 3993.0616305168264, 4001.5998400160333, 4021.356582946773, 4035.051762835731, 4047.615476529725, 4363.47638283408, 4667.229907065296, 4670.719756814534, 4672.135654903854, 4712.363830882856, 4655.231886738718, 5308.283381743492, 5814.738336774855, 5832.62087964281, 5864.472197502245, 1216.8235605837103, 1240.4232032105115, 1366.706158175997, 1380.9654758631114, 1387.653086728318, 897.8955884262264, 951.9671156794955, 952.9327153588026, 953.8712273843081, 964.8263312603658, 5215.913634546212, 5303.443138470482, 5309.628326017141, 5314.601404894648, 5382.973085134628, 4928.383952005999, 5247.685138891678, 5668.234788303609, 5703.69000554776, 5716.684323092596, 4210.536840947493, 4824.734639594786, 4959.330490383752, 5022.0, 5216.947830521646, 2702.662167229096, 2960.6676995352177, 2968.836713980752, 2969.4061187762536, 2989.611350524418, 5464.562834973192, 5618.033688209094, 5765.798197063083, 5854.619449735754, 5877.796600852545, 5070.569001634829, 5209.453007434165, 5714.571407144481, 6118.388161183846, 6138.539609529304, 5427.755750991215, 5613.803516876889, 5678.432156784289, 6230.750769969241, 6237.313895471494, 5441.319835020622, 5695.0, 5784.363719990882, 6005.489533389711, 6018.699065046818, 5884.735186916685, 5888.882222355614, 5894.410558944071, 5895.67573783446, 5917.260342457193, 4597.70114942541, 4916.852494425173, 5187.818426355059, 5856.344206356042, 6228.0, 3763.2661630981697, 4008.518977722692, 4018.5378681452007, 4018.9598104018587, 4027.9527322896843, 5089.6691715038405, 5971.611845230046, 5990.723525060449, 6006.399360063959, 6031.73809821317, 4695.342652028787, 5560.777568897361, 5703.258576385209, 5868.735906884286, 5918.6029657986865, 5289.170293892749, 5482.956958887856, 5718.742656580547, 5762.913556296575, 5822.854428639318, 4780.139574876555, 4794.986105835487, 5673.631213971079, 5716.256197025368, 5724.542036636975, 4795.496472870298, 5417.916416716751, 5797.072468405035, 5841.561882858718, 5849.888521180962, 4990.051890140861, 5609.326880774333, 5725.570582206435, 5746.896675795191, 5757.222774925332], "value": 4188.459343262423, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [709.8083517450289, 738.47937204271, 757.0839284465796, 776.8485145396646, 800.8838718385831, 15132.546023619296, 15577.532674019769, 15711.0, 15739.842601573995, 15769.448069317561, 13037.0, 13130.277834719087, 13181.60455186346, 13231.338433078332, 13297.800532991989, 842.4145219072747, 846.2552953400999, 859.9269062129711, 879.4547380624022, 879.7624641346832, 867.5402036920442, 869.1873098652749, 875.7547886591765, 878.5826732302137, 878.9165029322204, 882.4396508217296, 886.685226744506, 912.3795818843184, 920.0845159066738, 921.0, 869.8216865542548, 870.4168207301124, 874.5670892907988, 876.8947726272856, 908.259768288849, 664.3821246240994, 681.495693187043, 686.7664993902097, 687.542784048612, 688.7417218543046, 12897.742045159044, 12954.676133096653, 13098.410571524304, 13192.274424906625, 13537.86462135376, 11924.95986363549, 11933.462994165197, 11966.102542309362, 12030.0, 12157.574484892986, 9625.326227164102, 10844.186685998582, 11070.0, 11083.944580277128, 11552.942235288854, 4500.954990450086, 4560.384348112995, 4593.977030114861, 4607.35497030416, 4618.884527886829, 66148.00777988334, 70726.64636676783, 87856.12143878607, 92237.53881230619, 97663.0, 10904.836427453594, 10914.836277455845, 10991.175661825395, 11053.723656908642, 11261.099112071015, 20412.693809592867, 20441.977901104885, 20547.794522054886, 20658.79341206599, 20734.274300399717, 7584.4311676624475, 7711.652975616111, 7913.485623434458, 8136.064352599408, 8160.918390816016, 4437.64498840092, 4462.397576327155, 4574.908501830011, 4584.129015487047, 4662.160811054043, 3418.9487157692656, 3474.722022238215, 3493.6681015304016, 3541.327147841902, 3541.681248687579, 658.7430901948148, 659.5548005096541, 662.1888186970922, 665.6239224837951, 673.8483841135705, 582.967936763482, 600.5465873265656, 621.4220774679501, 691.8789211888001, 697.7034760226985, 9058.954705226564, 9507.619695212252, 9615.5672994714, 9620.086091821266, 9690.95154524237, 621.4375989729302, 655.757369773187, 674.7537148940602, 682.2358957967109, 691.3190507350256, 3503.8072905989907, 4438.800253988578, 4460.7323560586465, 4625.283081122431, 4771.403574553181, 87599.56200218959, 87762.56118719366, 88777.0, 88865.55567222252, 91814.0, 53656.73171634117, 63584.68207658932, 69246.0, 73138.0, 95126.5243673791, 83663.0, 86437.0, 87573.0, 88122.0, 89945.0, 9684.70945871625, 9772.413655180711, 10030.64892728751, 10046.346987445793, 10089.394636321844, 36783.44824827576, 53156.46843531515, 56352.87294254174, 56969.715151423974, 57670.55823604443, 76047.61976190304, 79329.60335198518, 80246.5987670058, 81717.0, 82239.17760822315, 12239.0, 12659.050571207381, 12697.8095328572, 12882.806757898827, 12939.935300323437, 13991.510297139552, 14220.502282420066, 14242.643933901321, 14662.63343416423, 14797.260136993322, 12819.230846149261, 13306.0, 13535.458581656623, 13635.522756703864, 14089.013769036479, 10959.397233151934, 13168.539101131415, 13247.470101195844, 13776.448942042207, 14051.156930584199, 12814.807777883525, 13140.474381025035, 13189.868101318863, 13262.27057511846, 13662.658433539242, 11196.440177991231, 11407.828882566933, 11575.710607234887, 11706.824397633873, 11845.526178952745, 11303.0, 11371.327737981734, 11445.48495317696, 11539.019183369508, 11540.307581545134], "value": 7377.798371514964, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1537.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 120.0, 116.0, 116.0, 118.0, 116.0, 118.0, 116.0, 116.0, 116.0], "value": 115.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 110.0, 110.0, 146.0, 111.0, 113.0, 110.0, 95.0, 144.0, 145.0], "value": 122.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [200.0, 200.0, 231.0, 284.0, 244.0, 246.0, 223.0, 203.0, 198.0, 199.0], "value": 222.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 60.0, 61.0, 102.0, 85.0, 83.0, 81.0, 86.0, 93.0, 60.0], "value": 79.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 69.0, 84.0, 74.0, 68.0, 102.0, 119.0, 91.0, 73.0, 85.0], "value": 85.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 94.0, 120.0, 91.0, 89.0, 123.0, 88.0, 90.0, 88.0], "value": 96.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 95.0, 95.0, 96.0, 95.0, 110.0, 97.0, 97.0, 94.0], "value": 97.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 92.0, 86.0, 85.0, 88.0, 94.0, 99.0, 91.0, 106.0, 132.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 54.0, 56.0, 58.0, 60.0, 60.0, 59.0, 59.0, 59.0], "value": 57.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 71.0, 77.0, 75.0, 71.0, 69.0, 71.0, 69.0, 70.0], "value": 70.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 90.0, 77.0, 73.0, 84.0, 79.0, 101.0, 103.0, 106.0, 103.0], "value": 91.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 162.0, 153.0, 137.0, 140.0, 142.0, 140.0, 144.0, 179.0, 136.0], "value": 148.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 166.0, 161.0, 165.0, 167.0, 186.0, 230.0, 192.0, 168.0, 166.0], "value": 176.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 72.0, 75.0, 86.0, 87.0, 60.0, 78.0, 87.0, 87.0, 86.0], "value": 78.8, "unit": "score"}]}]} 10:25:59 INFO - Return code: 0 10:25:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:25:59 ERROR - # TBPL SUCCESS # 10:25:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:25:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:25:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:25:59 INFO - 2017-02-03 10:25:59.248 screenresolution[1661:10416] starting screenresolution argv=screenresolution get 10:25:59 INFO - 2017-02-03 10:25:59.253 screenresolution[1661:10416] Display 0: 1600x1200x32@60 10:25:59 INFO - 2017-02-03 10:25:59.259 screenresolution[1662:10419] starting screenresolution argv=screenresolution list 10:25:59 INFO - Available Modes on Display 0 10:25:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:25:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:25:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:25:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:25:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:25:59 INFO - Intel Iris: 10:25:59 INFO - Chipset Model: Intel Iris 10:25:59 INFO - Type: GPU 10:25:59 INFO - Bus: Built-In 10:25:59 INFO - VRAM (Dynamic, Max): 1536 MB 10:25:59 INFO - Vendor: Intel (0x8086) 10:25:59 INFO - Device ID: 0x0a2e 10:25:59 INFO - Revision ID: 0x0009 10:25:59 INFO - Displays: 10:25:59 INFO - Display: 10:25:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:25:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:25:59 INFO - Display Serial Number: 1600x1200 60 10:25:59 INFO - Main Display: Yes 10:25:59 INFO - Mirror: Off 10:25:59 INFO - Online: Yes 10:25:59 INFO - Rotation: Supported 10:25:59 INFO - Return code: 0 10:25:59 INFO - Running post-action listener: _resource_record_post_action 10:25:59 INFO - [mozharness: 2017-02-03 18:25:59.504350Z] Finished run-tests step (success) 10:25:59 INFO - Running post-run listener: _resource_record_post_run 10:25:59 INFO - Total resource usage - Wall time: 1196s; CPU: 54.0%; Read bytes: 38680576; Write bytes: 497745920; Read time: 250; Write time: 1604 10:25:59 INFO - TinderboxPrint: CPU usage
54.3% 10:25:59 INFO - TinderboxPrint: I/O read bytes / time
38,680,576 / 250 10:25:59 INFO - TinderboxPrint: I/O write bytes / time
497,745,920 / 1,604 10:25:59 INFO - TinderboxPrint: CPU idle
2,188.4 (45.7%) 10:25:59 INFO - TinderboxPrint: CPU system
967.0 (20.2%) 10:25:59 INFO - TinderboxPrint: CPU user
1,630.3 (34.1%) 10:25:59 INFO - TinderboxPrint: Swap in / out
230,047,744 / 0 10:25:59 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 183263744; Write bytes: 176175104; Read time: 16727; Write time: 385 10:25:59 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 37709824; Write bytes: 303839232; Read time: 235; Write time: 1165 10:25:59 INFO - Running post-run listener: _upload_blobber_files 10:25:59 INFO - Blob upload gear active. 10:25:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:25:59 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:25:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:25:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:26:00 INFO - (blobuploader) - INFO - Open directory for files ... 10:26:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:26:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:26:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:26:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:26:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:26:01 INFO - (blobuploader) - INFO - Done attempting. 10:26:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:26:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:26:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:26:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:26:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:26:02 INFO - (blobuploader) - INFO - Done attempting. 10:26:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:26:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:26:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:26:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:26:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:26:05 INFO - (blobuploader) - INFO - Done attempting. 10:26:05 INFO - (blobuploader) - INFO - Iteration through files over. 10:26:05 INFO - Return code: 0 10:26:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:26:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:26:05 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/426bbdbb88c3d77435c9c6ea92efc4bc05a5adc9de4d9547e284e50eaca3f06452a5608d89c702e4d88c8762fbb05f4d371042be8b3e95435255c95702ae00b7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2ebf9c2119137fb9fee700ef2eae8cd92bb0a75f4456b1b6f01eaa3ca7cea811369627da65c0bddb3d6adf5f73c685ce33ec7f30716cdc834f79b884087e841a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/05ca60541df7563f9170d15ad3e82c99f8456d2babc8aa41d4f6ff080f48ad838a54eaba9139fafa98a08e4b65099999a06aff2815492c219e81fefe6211e4d4"} 10:26:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:26:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:26:05 INFO - Contents: 10:26:05 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/426bbdbb88c3d77435c9c6ea92efc4bc05a5adc9de4d9547e284e50eaca3f06452a5608d89c702e4d88c8762fbb05f4d371042be8b3e95435255c95702ae00b7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2ebf9c2119137fb9fee700ef2eae8cd92bb0a75f4456b1b6f01eaa3ca7cea811369627da65c0bddb3d6adf5f73c685ce33ec7f30716cdc834f79b884087e841a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/05ca60541df7563f9170d15ad3e82c99f8456d2babc8aa41d4f6ff080f48ad838a54eaba9139fafa98a08e4b65099999a06aff2815492c219e81fefe6211e4d4"} 10:26:05 INFO - Running post-run listener: copy_logs_to_upload_dir 10:26:05 INFO - Copying logs to upload dir... 10:26:05 INFO - mkdir: /builds/slave/test/build/upload/logs 10:26:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.743318 ========= master_lag: 1.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-02-03 10:26:06.136140) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-03 10:26:06.137506) ========= 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.qivElZA6ZR/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.QWiOqwkFRz/Listeners TMPDIR=/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/426bbdbb88c3d77435c9c6ea92efc4bc05a5adc9de4d9547e284e50eaca3f06452a5608d89c702e4d88c8762fbb05f4d371042be8b3e95435255c95702ae00b7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2ebf9c2119137fb9fee700ef2eae8cd92bb0a75f4456b1b6f01eaa3ca7cea811369627da65c0bddb3d6adf5f73c685ce33ec7f30716cdc834f79b884087e841a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/05ca60541df7563f9170d15ad3e82c99f8456d2babc8aa41d4f6ff080f48ad838a54eaba9139fafa98a08e4b65099999a06aff2815492c219e81fefe6211e4d4"} build_url:https://queue.taskcluster.net/v1/task/dqyKb6dVTjmf1FK_9gQXYQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011047 build_url: 'https://queue.taskcluster.net/v1/task/dqyKb6dVTjmf1FK_9gQXYQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/426bbdbb88c3d77435c9c6ea92efc4bc05a5adc9de4d9547e284e50eaca3f06452a5608d89c702e4d88c8762fbb05f4d371042be8b3e95435255c95702ae00b7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2ebf9c2119137fb9fee700ef2eae8cd92bb0a75f4456b1b6f01eaa3ca7cea811369627da65c0bddb3d6adf5f73c685ce33ec7f30716cdc834f79b884087e841a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/05ca60541df7563f9170d15ad3e82c99f8456d2babc8aa41d4f6ff080f48ad838a54eaba9139fafa98a08e4b65099999a06aff2815492c219e81fefe6211e4d4"}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-03 10:26:06.189950) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 2 secs) (at 2017-02-03 10:26:06.190359) ========= 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.qivElZA6ZR/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.QWiOqwkFRz/Listeners TMPDIR=/var/folders/k0/k2bv9k_d1hj2csl792zsg9v800000w/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.004575 ========= master_lag: 2.95 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 2 secs) (at 2017-02-03 10:26:09.145940) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-03 10:26:09.146299) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-03 10:26:09.152332) ========= ========= Total master_lag: 4.12 =========