builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0262 starttime: 1475578021.74 results: success (0) buildid: 20161004001902 builduid: 50a13ba6d819450fadd490f7900a21e8 revision: f927dc3ad86478c7b54507fa8cf862cff4f372b4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 03:47:01.739485) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 03:47:01.739962) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 03:47:01.740248) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 03:47:01.763963) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 03:47:01.764241) ========= 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.1Lbz7SntsU/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.FJI4NFwUdF/Listeners TMPDIR=/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-04 03:47:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 161M=0s 2016-10-04 03:47:01 (161 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.123690 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 03:47:01.913057) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 03:47:01.913383) ========= 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.1Lbz7SntsU/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.FJI4NFwUdF/Listeners TMPDIR=/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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.026730 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 03:47:01.961340) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-04 03:47:01.961663) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f927dc3ad86478c7b54507fa8cf862cff4f372b4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev f927dc3ad86478c7b54507fa8cf862cff4f372b4 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.1Lbz7SntsU/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.FJI4NFwUdF/Listeners TMPDIR=/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-04 03:47:02,031 truncating revision to first 12 chars 2016-10-04 03:47:02,031 Setting DEBUG logging. 2016-10-04 03:47:02,031 attempt 1/10 2016-10-04 03:47:02,031 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f927dc3ad864?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-04 03:47:03,129 unpacking tar archive at: fx-team-f927dc3ad864/testing/mozharness/ program finished with exit code 0 elapsedTime=1.381249 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-04 03:47:03.370787) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 03:47:03.371124) ========= script_repo_revision: f927dc3ad86478c7b54507fa8cf862cff4f372b4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 03:47:03.371542) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 03:47:03.371834) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 03:47:03.390368) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-10-04 03:47:03.390659) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.1Lbz7SntsU/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.FJI4NFwUdF/Listeners TMPDIR=/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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 03:47:03 INFO - MultiFileLogger online at 20161004 03:47:03 in /builds/slave/test 03:47:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 03:47:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:47:03 INFO - {'append_to_log': False, 03:47:03 INFO - 'base_work_dir': '/builds/slave/test', 03:47:03 INFO - 'blob_upload_branch': 'Fx-Team', 03:47:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:47:03 INFO - 'branch': 'Fx-Team', 03:47:03 INFO - 'buildbot_json_path': 'buildprops.json', 03:47:03 INFO - 'config_files': ('talos/mac_config.py',), 03:47:03 INFO - 'default_actions': ('clobber', 03:47:03 INFO - 'read-buildbot-config', 03:47:03 INFO - 'download-and-extract', 03:47:03 INFO - 'populate-webroot', 03:47:03 INFO - 'create-virtualenv', 03:47:03 INFO - 'install', 03:47:03 INFO - 'run-tests'), 03:47:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:47:03 INFO - 'download_minidump_stackwalk': True, 03:47:03 INFO - 'download_symbols': 'ondemand', 03:47:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:47:03 INFO - 'tooltool.py': '/tools/tooltool.py', 03:47:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:47:03 INFO - '/tools/misc-python/virtualenv.py')}, 03:47:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:47:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:47:03 INFO - 'installer_path': 'installer.exe', 03:47:03 INFO - 'log_level': 'info', 03:47:03 INFO - 'log_name': 'talos', 03:47:03 INFO - 'log_to_console': True, 03:47:03 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:47:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:47:03 INFO - 'opt_config_files': (), 03:47:03 INFO - 'pip_index': False, 03:47:03 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:47:03 INFO - 'cmd': ('bash', 03:47:03 INFO - '-c', 03:47:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:47:03 INFO - 'enabled': True, 03:47:03 INFO - 'halt_on_failure': False, 03:47:03 INFO - 'name': 'check_screen_resolution'},), 03:47:03 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:47:03 INFO - 'cmd': ('bash', 03:47:03 INFO - '-c', 03:47:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:47:03 INFO - 'enabled': True, 03:47:03 INFO - 'halt_on_failure': False, 03:47:03 INFO - 'name': 'check_screen_resolution'},), 03:47:03 INFO - 'run_cmd_checks_enabled': True, 03:47:03 INFO - 'sps_profile': False, 03:47:03 INFO - 'sps_profile_interval': 0, 03:47:03 INFO - 'suite': 'dromaeojs-e10s', 03:47:03 INFO - 'system_bits': '32', 03:47:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:47:03 INFO - 'title': 't-yosemite-r7-0262', 03:47:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:47:03 INFO - 'use_talos_json': True, 03:47:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:47:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:47:03 INFO - 'work_dir': 'build'} 03:47:03 INFO - [mozharness: 2016-10-04 10:47:03.594443Z] Running clobber step. 03:47:03 INFO - Running pre-action listener: _resource_record_pre_action 03:47:03 INFO - Running main action method: clobber 03:47:03 INFO - rmtree: /builds/slave/test/build 03:47:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:47:05 INFO - Running post-action listener: _resource_record_post_action 03:47:05 INFO - [mozharness: 2016-10-04 10:47:05.712650Z] Finished clobber step (success) 03:47:05 INFO - [mozharness: 2016-10-04 10:47:05.712762Z] Running read-buildbot-config step. 03:47:05 INFO - Running pre-action listener: _resource_record_pre_action 03:47:05 INFO - Running main action method: read_buildbot_config 03:47:05 INFO - Using buildbot properties: 03:47:05 INFO - { 03:47:05 INFO - "project": "", 03:47:05 INFO - "product": "firefox", 03:47:05 INFO - "script_repo_revision": "production", 03:47:05 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 03:47:05 INFO - "repository": "", 03:47:05 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 03:47:05 INFO - "buildid": "20161004001902", 03:47:05 INFO - "pgo_build": "False", 03:47:05 INFO - "basedir": "/builds/slave/test", 03:47:05 INFO - "buildnumber": 31, 03:47:05 INFO - "slavename": "t-yosemite-r7-0262", 03:47:05 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 03:47:05 INFO - "platform": "yosemite_r7", 03:47:05 INFO - "scheduler": "tests-fx-team-macosx64-talos-8-3600", 03:47:05 INFO - "branch": "fx-team", 03:47:05 INFO - "repo_path": "integration/fx-team", 03:47:05 INFO - "revision": "f927dc3ad86478c7b54507fa8cf862cff4f372b4", 03:47:05 INFO - "stage_platform": "macosx64", 03:47:05 INFO - "builduid": "50a13ba6d819450fadd490f7900a21e8", 03:47:05 INFO - "slavebuilddir": "test" 03:47:05 INFO - } 03:47:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/Eb-HMLHIRC6RXE5ppQbLyw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 03:47:05 INFO - Running post-action listener: _resource_record_post_action 03:47:05 INFO - [mozharness: 2016-10-04 10:47:05.716004Z] Finished read-buildbot-config step (success) 03:47:05 INFO - [mozharness: 2016-10-04 10:47:05.716107Z] Running download-and-extract step. 03:47:05 INFO - Running pre-action listener: _resource_record_pre_action 03:47:05 INFO - Running main action method: download_and_extract 03:47:05 INFO - mkdir: /builds/slave/test/build/tests 03:47:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:47:05 INFO - trying https://queue.taskcluster.net/v1/task/Eb-HMLHIRC6RXE5ppQbLyw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 03:47:05 INFO - Downloading https://queue.taskcluster.net/v1/task/Eb-HMLHIRC6RXE5ppQbLyw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 03:47:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Eb-HMLHIRC6RXE5ppQbLyw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 03:47:07 INFO - Downloaded 1199 bytes. 03:47:07 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 03:47:07 INFO - Using the following test package requirements: 03:47:07 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 03:47:07 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:47:07 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 03:47:07 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:47:07 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 03:47:07 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:47:07 INFO - u'jsshell-mac.zip'], 03:47:07 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:47:07 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 03:47:07 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 03:47:07 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:47:07 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 03:47:07 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:47:07 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 03:47:07 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:47:07 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 03:47:07 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:47:07 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 03:47:07 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:47:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Eb-HMLHIRC6RXE5ppQbLyw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 03:47:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Eb-HMLHIRC6RXE5ppQbLyw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:47:07 INFO - Fetch https://queue.taskcluster.net/v1/task/Eb-HMLHIRC6RXE5ppQbLyw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 03:47:07 INFO - Http code: 200 03:47:07 INFO - via: 1.1 41b2ee7cbe95749816a7586d9ab4629d.cloudfront.net (CloudFront) 03:47:07 INFO - x-amz-cf-id: PYyeT7gtu0UI679tf8cgDv8T27dlHpFG2uZaJkVYBihhnVg1fFdSMg== 03:47:07 INFO - x-amz-version-id: x9JrSDYTo9_XYZAQsgkPjiw2Anavgqbp 03:47:07 INFO - Expected file size: 16476710 03:47:07 INFO - Obtained file size: 16476710 03:47:14 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 03:47:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Eb-HMLHIRC6RXE5ppQbLyw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 03:47:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Eb-HMLHIRC6RXE5ppQbLyw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:47:14 INFO - Fetch https://queue.taskcluster.net/v1/task/Eb-HMLHIRC6RXE5ppQbLyw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 03:47:15 INFO - Http code: 200 03:47:15 INFO - via: 1.1 336f0e6ef9a3462f682d6ca49029b665.cloudfront.net (CloudFront) 03:47:15 INFO - x-amz-cf-id: G_psd_Oe8JydtJZ_4VKbq1eEfIHzmk6ntu_XqIeU2D27T97YtlzHvg== 03:47:15 INFO - x-amz-version-id: x9JrSDYTo9_XYZAQsgkPjiw2Anavgqbp 03:47:15 INFO - Expected file size: 16476710 03:47:15 INFO - Obtained file size: 16476710 03:47:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Eb-HMLHIRC6RXE5ppQbLyw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 03:47:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Eb-HMLHIRC6RXE5ppQbLyw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 03:47:21 INFO - Fetch https://queue.taskcluster.net/v1/task/Eb-HMLHIRC6RXE5ppQbLyw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 03:47:22 INFO - Http code: 200 03:47:22 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 03:47:22 INFO - x-amz-cf-id: uatZTz4y2WkKiBm8K2IKZfgWsJBLRd8r5pDxSOOCUuj9c0hQttjYLg== 03:47:22 INFO - x-amz-version-id: KXDIg3xg4he0BX09vdw3dv_y8rUmrBr3 03:47:23 INFO - Expected file size: 14409006 03:47:23 INFO - Obtained file size: 14409006 03:47:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:47:23 INFO - trying https://queue.taskcluster.net/v1/task/Eb-HMLHIRC6RXE5ppQbLyw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 03:47:23 INFO - Downloading https://queue.taskcluster.net/v1/task/Eb-HMLHIRC6RXE5ppQbLyw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 03:47:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Eb-HMLHIRC6RXE5ppQbLyw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 03:47:26 INFO - Downloaded 111656655 bytes. 03:47:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Eb-HMLHIRC6RXE5ppQbLyw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 03:47:26 INFO - mkdir: /builds/slave/test/properties 03:47:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:47:26 INFO - Writing to file /builds/slave/test/properties/build_url 03:47:26 INFO - Contents: 03:47:26 INFO - build_url:https://queue.taskcluster.net/v1/task/Eb-HMLHIRC6RXE5ppQbLyw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 03:47:26 INFO - Running post-action listener: _resource_record_post_action 03:47:26 INFO - Running post-action listener: set_extra_try_arguments 03:47:26 INFO - [mozharness: 2016-10-04 10:47:26.884003Z] Finished download-and-extract step (success) 03:47:26 INFO - [mozharness: 2016-10-04 10:47:26.884135Z] Running populate-webroot step. 03:47:26 INFO - Running pre-action listener: _resource_record_pre_action 03:47:26 INFO - Running main action method: populate_webroot 03:47:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:47:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:47:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:47:26 INFO - '--tppagecycles', 03:47:26 INFO - '7'], 03:47:26 INFO - 'tests': ['tsvgm']}}, 03:47:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:47:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:47:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:47:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:47:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:47:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:47:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:26 INFO - 'talos_options': ['--disable-e10s'], 03:47:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:47:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:47:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:26 INFO - 'talos_options': ['--disable-e10s'], 03:47:26 INFO - 'tests': ['damp', 'tps']}, 03:47:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:26 INFO - 'tests': ['damp', 'tps']}, 03:47:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:47:26 INFO - 'tests': ['dromaeo_dom']}, 03:47:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:47:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:47:26 INFO - 'tests': ['basic_compositor_video']}, 03:47:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:47:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:47:26 INFO - 'tests': ['a11yr', 03:47:26 INFO - 'ts_paint', 03:47:26 INFO - 'tpaint', 03:47:26 INFO - 'sessionrestore', 03:47:26 INFO - 'sessionrestore_no_auto_restore', 03:47:26 INFO - 'tabpaint']}, 03:47:26 INFO - 'other-e10s': {'tests': ['a11yr', 03:47:26 INFO - 'ts_paint', 03:47:26 INFO - 'tpaint', 03:47:26 INFO - 'sessionrestore', 03:47:26 INFO - 'sessionrestore_no_auto_restore', 03:47:26 INFO - 'tabpaint']}, 03:47:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:47:26 INFO - 'ts_paint', 03:47:26 INFO - 'tpaint', 03:47:26 INFO - 'sessionrestore', 03:47:26 INFO - 'sessionrestore_no_auto_restore', 03:47:26 INFO - 'tabpaint']}, 03:47:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:47:26 INFO - 'ts_paint', 03:47:26 INFO - 'tpaint', 03:47:26 INFO - 'sessionrestore', 03:47:26 INFO - 'sessionrestore_no_auto_restore', 03:47:26 INFO - 'tabpaint']}, 03:47:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:47:26 INFO - 'tests': ['a11yr', 03:47:26 INFO - 'ts_paint', 03:47:26 INFO - 'tpaint', 03:47:26 INFO - 'sessionrestore', 03:47:26 INFO - 'sessionrestore_no_auto_restore', 03:47:26 INFO - 'tabpaint']}, 03:47:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:47:26 INFO - 'tests': ['a11yr', 03:47:26 INFO - 'ts_paint', 03:47:26 INFO - 'tpaint', 03:47:26 INFO - 'sessionrestore', 03:47:26 INFO - 'sessionrestore_no_auto_restore', 03:47:26 INFO - 'tabpaint']}, 03:47:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:47:26 INFO - 'tests': ['tsvgx', 03:47:26 INFO - 'tsvgr_opacity', 03:47:26 INFO - 'tart', 03:47:26 INFO - 'tscrollx', 03:47:26 INFO - 'cart']}, 03:47:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:47:26 INFO - 'tsvgr_opacity', 03:47:26 INFO - 'tart', 03:47:26 INFO - 'tscrollx', 03:47:26 INFO - 'cart']}, 03:47:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:26 INFO - 'talos_options': ['--disable-e10s'], 03:47:26 INFO - 'tests': ['tp5o']}, 03:47:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:26 INFO - 'tests': ['tp5o']}, 03:47:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:26 INFO - 'talos_options': ['--disable-e10s', 03:47:26 INFO - '--xperf_path', 03:47:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:47:26 INFO - 'tests': ['tp5n']}, 03:47:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:26 INFO - 'talos_options': ['--xperf_path', 03:47:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:47:26 INFO - 'tests': ['tp5n']}}, 03:47:26 INFO - 'talos.zip': {'path': '', 03:47:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:47:26 INFO - Running post-action listener: _resource_record_post_action 03:47:26 INFO - [mozharness: 2016-10-04 10:47:26.902849Z] Finished populate-webroot step (success) 03:47:26 INFO - [mozharness: 2016-10-04 10:47:26.902956Z] Running create-virtualenv step. 03:47:26 INFO - Running pre-action listener: _resource_record_pre_action 03:47:26 INFO - Running main action method: create_virtualenv 03:47:26 INFO - Creating virtualenv /builds/slave/test/build/venv 03:47:26 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:47:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:47:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:47:27 INFO - Using real prefix '/tools/python27' 03:47:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:47:27 INFO - Installing distribute.............................................................................................................................................................................................done. 03:47:30 INFO - Installing pip.................done. 03:47:30 INFO - Return code: 0 03:47:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:47:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:47:30 INFO - Reading from file tmpfile_stdout 03:47:30 INFO - Output received: 03:47:30 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 03:47:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:47:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:47:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:47:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dd67490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dcdd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa83bd9ece0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db7bd30>, '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 0x10d9a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db73b20>, '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.1Lbz7SntsU/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.FJI4NFwUdF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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 03:47:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:47:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:47:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1Lbz7SntsU/Render', 03:47:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:47:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:47:30 INFO - 'HOME': '/Users/cltbld', 03:47:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:47:30 INFO - 'LOGNAME': 'cltbld', 03:47:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:30 INFO - 'MOZ_NO_REMOTE': '1', 03:47:30 INFO - 'NO_EM_RESTART': '1', 03:47:30 INFO - 'PAGER': '/bin/cat', 03:47:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:47:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:47:30 INFO - 'PWD': '/builds/slave/test', 03:47:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:47:30 INFO - 'SHELL': '/bin/bash', 03:47:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FJI4NFwUdF/Listeners', 03:47:30 INFO - 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/', 03:47:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:47:30 INFO - 'USER': 'cltbld', 03:47:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:47:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:47:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:30 INFO - 'XPC_FLAGS': '0x0', 03:47:30 INFO - 'XPC_SERVICE_NAME': '0', 03:47:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:47:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:31 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 03:47:31 INFO - Cleaning up... 03:47:31 INFO - Return code: 0 03:47:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:47:31 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')]} 03:47:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:31 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')]} 03:47:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:31 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 0x10dd67490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dcdd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa83bd9ece0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db7bd30>, '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 0x10d9a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db73b20>, '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.1Lbz7SntsU/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.FJI4NFwUdF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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 03:47:31 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 03:47:31 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 03:47:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1Lbz7SntsU/Render', 03:47:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:47:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:47:31 INFO - 'HOME': '/Users/cltbld', 03:47:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:47:31 INFO - 'LOGNAME': 'cltbld', 03:47:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:31 INFO - 'MOZ_NO_REMOTE': '1', 03:47:31 INFO - 'NO_EM_RESTART': '1', 03:47:31 INFO - 'PAGER': '/bin/cat', 03:47:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:47:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:47:31 INFO - 'PWD': '/builds/slave/test', 03:47:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:47:31 INFO - 'SHELL': '/bin/bash', 03:47:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FJI4NFwUdF/Listeners', 03:47:31 INFO - 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/', 03:47:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:47:31 INFO - 'USER': 'cltbld', 03:47:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:47:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:47:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:31 INFO - 'XPC_FLAGS': '0x0', 03:47:31 INFO - 'XPC_SERVICE_NAME': '0', 03:47:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:47:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:31 INFO - Downloading/unpacking psutil>=3.1.1 03:47:31 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 03:47:31 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 03:47:31 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 03:47:31 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 03:47:31 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 03:47:31 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 03:47:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:47:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:47:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:47:34 INFO - Installing collected packages: psutil 03:47:34 INFO - Running setup.py install for psutil 03:47:34 INFO - building 'psutil._psutil_osx' extension 03:47:34 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 03:47:35 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 03:47:35 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 03:47:35 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 03:47:35 INFO - building 'psutil._psutil_posix' extension 03:47:35 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 03:47:35 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:47:35 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:47:35 INFO - ^ 03:47:35 INFO - 1 warning generated. 03:47:35 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 03:47:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:47:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:47:35 INFO - Successfully installed psutil 03:47:35 INFO - Cleaning up... 03:47:36 INFO - Return code: 0 03:47:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:47:36 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')]} 03:47:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:36 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')]} 03:47:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:36 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 0x10dd67490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dcdd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa83bd9ece0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db7bd30>, '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 0x10d9a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db73b20>, '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.1Lbz7SntsU/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.FJI4NFwUdF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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 03:47:36 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 03:47:36 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 03:47:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1Lbz7SntsU/Render', 03:47:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:47:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:47:36 INFO - 'HOME': '/Users/cltbld', 03:47:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:47:36 INFO - 'LOGNAME': 'cltbld', 03:47:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:36 INFO - 'MOZ_NO_REMOTE': '1', 03:47:36 INFO - 'NO_EM_RESTART': '1', 03:47:36 INFO - 'PAGER': '/bin/cat', 03:47:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:47:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:47:36 INFO - 'PWD': '/builds/slave/test', 03:47:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:47:36 INFO - 'SHELL': '/bin/bash', 03:47:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FJI4NFwUdF/Listeners', 03:47:36 INFO - 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/', 03:47:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:47:36 INFO - 'USER': 'cltbld', 03:47:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:47:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:47:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:36 INFO - 'XPC_FLAGS': '0x0', 03:47:36 INFO - 'XPC_SERVICE_NAME': '0', 03:47:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:47:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:47:36 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 03:47:36 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 03:47:36 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 03:47:36 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 03:47:36 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 03:47:36 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 03:47:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:47:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:47:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:47:38 INFO - Installing collected packages: mozsystemmonitor 03:47:38 INFO - Running setup.py install for mozsystemmonitor 03:47:38 INFO - Successfully installed mozsystemmonitor 03:47:38 INFO - Cleaning up... 03:47:39 INFO - Return code: 0 03:47:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:47:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:47:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:47:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10dd67490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dcdd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa83bd9ece0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db7bd30>, '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 0x10d9a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db73b20>, '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.1Lbz7SntsU/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.FJI4NFwUdF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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 03:47:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:47:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:47:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1Lbz7SntsU/Render', 03:47:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:47:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:47:39 INFO - 'HOME': '/Users/cltbld', 03:47:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:47:39 INFO - 'LOGNAME': 'cltbld', 03:47:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:39 INFO - 'MOZ_NO_REMOTE': '1', 03:47:39 INFO - 'NO_EM_RESTART': '1', 03:47:39 INFO - 'PAGER': '/bin/cat', 03:47:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:47:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:47:39 INFO - 'PWD': '/builds/slave/test', 03:47:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:47:39 INFO - 'SHELL': '/bin/bash', 03:47:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FJI4NFwUdF/Listeners', 03:47:39 INFO - 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/', 03:47:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:47:39 INFO - 'USER': 'cltbld', 03:47:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:47:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:47:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:39 INFO - 'XPC_FLAGS': '0x0', 03:47:39 INFO - 'XPC_SERVICE_NAME': '0', 03:47:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:47:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:39 INFO - Downloading/unpacking jsonschema==2.5.1 03:47:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:47:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:47: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 03:47: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 03:47: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 03:47: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 03:47: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 03:47: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 03:47:42 INFO - Downloading functools32-3.2.3-2.tar.gz 03:47:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:47:42 INFO - warning: no files found matching '*.txt' 03:47:42 INFO - no previously-included directories found matching 'build' 03:47:42 INFO - no previously-included directories found matching 'dist' 03:47:42 INFO - no previously-included directories found matching '.git*' 03:47:42 INFO - Installing collected packages: jsonschema, functools32 03:47:42 INFO - Running setup.py install for functools32 03:47:42 INFO - warning: no files found matching '*.txt' 03:47:42 INFO - no previously-included directories found matching 'build' 03:47:42 INFO - no previously-included directories found matching 'dist' 03:47:42 INFO - no previously-included directories found matching '.git*' 03:47:42 INFO - Successfully installed jsonschema functools32 03:47:42 INFO - Cleaning up... 03:47:42 INFO - Return code: 0 03:47:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:47:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:47:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:47:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dd67490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dcdd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa83bd9ece0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db7bd30>, '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 0x10d9a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db73b20>, '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.1Lbz7SntsU/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.FJI4NFwUdF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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 03:47:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:47:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:47:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1Lbz7SntsU/Render', 03:47:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:47:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:47:42 INFO - 'HOME': '/Users/cltbld', 03:47:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:47:42 INFO - 'LOGNAME': 'cltbld', 03:47:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:42 INFO - 'MOZ_NO_REMOTE': '1', 03:47:42 INFO - 'NO_EM_RESTART': '1', 03:47:42 INFO - 'PAGER': '/bin/cat', 03:47:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:47:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:47:42 INFO - 'PWD': '/builds/slave/test', 03:47:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:47:42 INFO - 'SHELL': '/bin/bash', 03:47:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FJI4NFwUdF/Listeners', 03:47:42 INFO - 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/', 03:47:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:47:42 INFO - 'USER': 'cltbld', 03:47:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:47:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:47:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:42 INFO - 'XPC_FLAGS': '0x0', 03:47:42 INFO - 'XPC_SERVICE_NAME': '0', 03:47:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:47:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:47:42 INFO - Cleaning up... 03:47:42 INFO - Return code: 0 03:47:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:47:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:47:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:47:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dd67490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dcdd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa83bd9ece0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db7bd30>, '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 0x10d9a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db73b20>, '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.1Lbz7SntsU/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.FJI4NFwUdF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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 03:47:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:47:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:47:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1Lbz7SntsU/Render', 03:47:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:47:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:47:42 INFO - 'HOME': '/Users/cltbld', 03:47:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:47:42 INFO - 'LOGNAME': 'cltbld', 03:47:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:42 INFO - 'MOZ_NO_REMOTE': '1', 03:47:42 INFO - 'NO_EM_RESTART': '1', 03:47:42 INFO - 'PAGER': '/bin/cat', 03:47:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:47:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:47:42 INFO - 'PWD': '/builds/slave/test', 03:47:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:47:42 INFO - 'SHELL': '/bin/bash', 03:47:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FJI4NFwUdF/Listeners', 03:47:42 INFO - 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/', 03:47:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:47:42 INFO - 'USER': 'cltbld', 03:47:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:47:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:47:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:42 INFO - 'XPC_FLAGS': '0x0', 03:47:42 INFO - 'XPC_SERVICE_NAME': '0', 03:47:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:47:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:42 INFO - Downloading/unpacking blobuploader==1.2.4 03:47:42 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 03:47:42 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 03:47:42 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 03:47:42 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 03:47:42 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 03:47:42 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 03:47:45 INFO - Downloading blobuploader-1.2.4.tar.gz 03:47:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:47:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:47: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 03:47: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 03:47: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 03:47: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 03:47: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 03:47: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 03:47:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:47:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:47:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:46 INFO - Downloading docopt-0.6.1.tar.gz 03:47:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:47:46 INFO - Installing collected packages: blobuploader, requests, docopt 03:47:46 INFO - Running setup.py install for blobuploader 03:47:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:47:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:47:46 INFO - Running setup.py install for requests 03:47:47 INFO - Running setup.py install for docopt 03:47:47 INFO - Successfully installed blobuploader requests docopt 03:47:47 INFO - Cleaning up... 03:47:47 INFO - Return code: 0 03:47:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:47:47 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')]} 03:47:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:47 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')]} 03:47:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:47 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 0x10dd67490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dcdd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa83bd9ece0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db7bd30>, '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 0x10d9a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db73b20>, '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.1Lbz7SntsU/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.FJI4NFwUdF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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 03:47:47 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 03:47:47 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 03:47:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1Lbz7SntsU/Render', 03:47:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:47:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:47:47 INFO - 'HOME': '/Users/cltbld', 03:47:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:47:47 INFO - 'LOGNAME': 'cltbld', 03:47:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:47 INFO - 'MOZ_NO_REMOTE': '1', 03:47:47 INFO - 'NO_EM_RESTART': '1', 03:47:47 INFO - 'PAGER': '/bin/cat', 03:47:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:47:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:47:47 INFO - 'PWD': '/builds/slave/test', 03:47:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:47:47 INFO - 'SHELL': '/bin/bash', 03:47:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FJI4NFwUdF/Listeners', 03:47:47 INFO - 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/', 03:47:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:47:47 INFO - 'USER': 'cltbld', 03:47:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:47:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:47:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:47 INFO - 'XPC_FLAGS': '0x0', 03:47:47 INFO - 'XPC_SERVICE_NAME': '0', 03:47:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:47:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:47:47 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-O4dukm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:47:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:47:47 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-zKZNmy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:47:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:47:48 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-Gagy4K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:47:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:47:48 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-0CIm3q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:47:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:47:48 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-ZpQZWe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:47:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:47:48 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-pXZWy9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:47:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:47:48 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-_aJwep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:47:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:47:48 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-ZFyVDb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:47:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:47:48 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-SMOrC2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:47:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:47:48 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-jRxSut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:47:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:47:48 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-HPHdLG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:47:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:47:49 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-NCxzOw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:47:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:47:49 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-qgnSPM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:47:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:47:49 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-u17zV_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:47:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:47:49 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-fzcyZ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:47:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:47:49 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-A9n4JX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:47:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:47:49 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-pqlL09-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:47:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:47:49 INFO - Running setup.py install for manifestparser 03:47:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:47:49 INFO - Running setup.py install for mozcrash 03:47:49 INFO - Running setup.py install for mozdebug 03:47:50 INFO - Running setup.py install for mozdevice 03:47:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:47:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:47:50 INFO - Running setup.py install for mozfile 03:47:50 INFO - Running setup.py install for mozhttpd 03:47:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:47:50 INFO - Running setup.py install for mozinfo 03:47:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:47:50 INFO - Running setup.py install for mozInstall 03:47:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:47:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:47:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:47:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:47:50 INFO - Running setup.py install for mozleak 03:47:50 INFO - Running setup.py install for mozlog 03:47:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:47:51 INFO - Running setup.py install for moznetwork 03:47:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:47:51 INFO - Running setup.py install for mozprocess 03:47:51 INFO - Running setup.py install for mozprofile 03:47:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:47:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:47:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:47:51 INFO - Running setup.py install for mozrunner 03:47:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:47:51 INFO - Running setup.py install for mozscreenshot 03:47:51 INFO - Running setup.py install for moztest 03:47:52 INFO - Running setup.py install for mozversion 03:47:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:47:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:47:52 INFO - Cleaning up... 03:47:52 INFO - Return code: 0 03:47:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:47:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:47:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:47:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dd67490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dcdd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa83bd9ece0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db7bd30>, '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 0x10d9a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db73b20>, '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.1Lbz7SntsU/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.FJI4NFwUdF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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 03:47:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:47:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:47:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1Lbz7SntsU/Render', 03:47:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:47:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:47:52 INFO - 'HOME': '/Users/cltbld', 03:47:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:47:52 INFO - 'LOGNAME': 'cltbld', 03:47:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:52 INFO - 'MOZ_NO_REMOTE': '1', 03:47:52 INFO - 'NO_EM_RESTART': '1', 03:47:52 INFO - 'PAGER': '/bin/cat', 03:47:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:47:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:47:52 INFO - 'PWD': '/builds/slave/test', 03:47:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:47:52 INFO - 'SHELL': '/bin/bash', 03:47:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FJI4NFwUdF/Listeners', 03:47:52 INFO - 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/', 03:47:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:47:52 INFO - 'USER': 'cltbld', 03:47:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:47:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:47:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:52 INFO - 'XPC_FLAGS': '0x0', 03:47:52 INFO - 'XPC_SERVICE_NAME': '0', 03:47:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:47:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:47:52 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-0WUkjk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:47:52 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)) 03:47:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:47:52 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-pdYfbt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:47:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 03:47:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:47:52 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-fyZLQw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:47:52 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)) 03:47:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:47:52 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-bM7Hyj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:47:52 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)) 03:47:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:47:52 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-H0Yjq9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:47:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:47:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:47:53 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-la5Rn9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:47:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:47:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:47:53 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-f5HWnJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:47:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:47:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:47:53 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-dU92aL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:47:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:47:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:47:53 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-eOiW4W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:47:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:47:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:47:53 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-5hLexr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:47:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:47:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:47:53 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-7_k6Cg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:47:53 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)) 03:47:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:47:53 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-yqjYPS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:47:53 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)) 03:47:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:47:53 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-p4QKbF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:47:53 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)) 03:47:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:47:53 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-9yTuY8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:47:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 03:47:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:47:54 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-xPzxJU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:47:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:47:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:47:54 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-C5SqLZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:47:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:47:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:47:54 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-ndRorL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:47:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:47:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:47:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:47:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:47:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:47:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:47:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:47:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:56 INFO - Downloading blessings-1.6.tar.gz 03:47:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:47:56 INFO - Installing collected packages: blessings 03:47:56 INFO - Running setup.py install for blessings 03:47:57 INFO - Successfully installed blessings 03:47:57 INFO - Cleaning up... 03:47:57 INFO - Return code: 0 03:47:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:47:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:47:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:47:57 INFO - Reading from file tmpfile_stdout 03:47:57 INFO - Current package versions: 03:47:57 INFO - blessings == 1.6 03:47:57 INFO - blobuploader == 1.2.4 03:47:57 INFO - docopt == 0.6.1 03:47:57 INFO - functools32 == 3.2.3-2 03:47:57 INFO - jsonschema == 2.5.1 03:47:57 INFO - manifestparser == 1.1 03:47:57 INFO - mozInstall == 1.12 03:47:57 INFO - mozcrash == 0.17 03:47:57 INFO - mozdebug == 0.1 03:47:57 INFO - mozdevice == 0.48 03:47:57 INFO - mozfile == 1.2 03:47:57 INFO - mozhttpd == 0.7 03:47:57 INFO - mozinfo == 0.9 03:47:57 INFO - mozleak == 0.1 03:47:57 INFO - mozlog == 3.4 03:47:57 INFO - moznetwork == 0.27 03:47:57 INFO - mozprocess == 0.23 03:47:57 INFO - mozprofile == 0.28 03:47:57 INFO - mozrunner == 6.12 03:47:57 INFO - mozscreenshot == 0.1 03:47:57 INFO - mozsystemmonitor == 0.3 03:47:57 INFO - moztest == 0.7 03:47:57 INFO - mozversion == 1.4 03:47:57 INFO - psutil == 3.1.1 03:47:57 INFO - requests == 1.2.3 03:47:57 INFO - wsgiref == 0.1.2 03:47:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:47:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:47:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:47:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:58 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 0x10dd67490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dcdd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa83bd9ece0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db7bd30>, '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 0x10d9a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db73b20>, '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.1Lbz7SntsU/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.FJI4NFwUdF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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 03:47:58 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 03:47:58 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 03:47:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1Lbz7SntsU/Render', 03:47:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:47:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:47:58 INFO - 'HOME': '/Users/cltbld', 03:47:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:47:58 INFO - 'LOGNAME': 'cltbld', 03:47:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:58 INFO - 'MOZ_NO_REMOTE': '1', 03:47:58 INFO - 'NO_EM_RESTART': '1', 03:47:58 INFO - 'PAGER': '/bin/cat', 03:47:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:47:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:47:58 INFO - 'PWD': '/builds/slave/test', 03:47:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:47:58 INFO - 'SHELL': '/bin/bash', 03:47:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FJI4NFwUdF/Listeners', 03:47:58 INFO - 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/', 03:47:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:47:58 INFO - 'USER': 'cltbld', 03:47:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:47:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:47:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:58 INFO - 'XPC_FLAGS': '0x0', 03:47:58 INFO - 'XPC_SERVICE_NAME': '0', 03:47:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:47:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:47:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:47:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:47:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:47:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:47:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:47:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:47:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:47:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:47:58 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:47:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:47:58 INFO - Cleaning up... 03:47:58 INFO - Return code: 0 03:47:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:47:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:47:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:47:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:59 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 0x10dd67490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dcdd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa83bd9ece0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db7bd30>, '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 0x10d9a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db73b20>, '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.1Lbz7SntsU/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.FJI4NFwUdF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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 03:47:59 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 03:47:59 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 03:47:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1Lbz7SntsU/Render', 03:47:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:47:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:47:59 INFO - 'HOME': '/Users/cltbld', 03:47:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:47:59 INFO - 'LOGNAME': 'cltbld', 03:47:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:59 INFO - 'MOZ_NO_REMOTE': '1', 03:47:59 INFO - 'NO_EM_RESTART': '1', 03:47:59 INFO - 'PAGER': '/bin/cat', 03:47:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:47:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:47:59 INFO - 'PWD': '/builds/slave/test', 03:47:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:47:59 INFO - 'SHELL': '/bin/bash', 03:47:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FJI4NFwUdF/Listeners', 03:47:59 INFO - 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/', 03:47:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:47:59 INFO - 'USER': 'cltbld', 03:47:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:47:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:47:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:59 INFO - 'XPC_FLAGS': '0x0', 03:47:59 INFO - 'XPC_SERVICE_NAME': '0', 03:47:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:47:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:47:59 INFO - Cleaning up... 03:47:59 INFO - Return code: 0 03:47:59 INFO - Running post-action listener: _resource_record_post_action 03:47:59 INFO - Running post-action listener: _start_resource_monitoring 03:47:59 INFO - Starting resource monitoring. 03:47:59 INFO - [mozharness: 2016-10-04 10:47:59.530385Z] Finished create-virtualenv step (success) 03:47:59 INFO - [mozharness: 2016-10-04 10:47:59.531342Z] Running install step. 03:47:59 INFO - Running pre-action listener: _resource_record_pre_action 03:47:59 INFO - Running main action method: install 03:47:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:47:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:47:59 INFO - Reading from file tmpfile_stdout 03:47:59 INFO - Detecting whether we're running mozinstall >=1.0... 03:47:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:47:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:47:59 INFO - Reading from file tmpfile_stdout 03:47:59 INFO - Output received: 03:47:59 INFO - Usage: mozinstall [options] installer 03:47:59 INFO - Options: 03:47:59 INFO - -h, --help show this help message and exit 03:47:59 INFO - -d DEST, --destination=DEST 03:47:59 INFO - Directory to install application into. [default: 03:47:59 INFO - "/builds/slave/test"] 03:47:59 INFO - --app=APP Application being installed. [default: firefox] 03:47:59 INFO - mkdir: /builds/slave/test/build/application 03:47:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 03:47:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 03:48:34 INFO - Reading from file tmpfile_stdout 03:48:34 INFO - Output received: 03:48:34 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:48:34 INFO - Running post-action listener: _resource_record_post_action 03:48:34 INFO - [mozharness: 2016-10-04 10:48:34.466610Z] Finished install step (success) 03:48:34 INFO - [mozharness: 2016-10-04 10:48:34.466734Z] Running run-tests step. 03:48:34 INFO - Running pre-action listener: _resource_record_pre_action 03:48:34 INFO - Running main action method: run_tests 03:48:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:48:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:48:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:48:34 INFO - 2016-10-04 03:48:34.481 screenresolution[1641:7532] starting screenresolution argv=screenresolution get 03:48:34 INFO - 2016-10-04 03:48:34.483 screenresolution[1641:7532] Display 0: 1600x1200x32@60 03:48:34 INFO - 2016-10-04 03:48:34.489 screenresolution[1642:7534] starting screenresolution argv=screenresolution list 03:48:34 INFO - Available Modes on Display 0 03:48:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:48:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:48:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:48:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:48:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:48:34 INFO - Intel Iris: 03:48:34 INFO - Chipset Model: Intel Iris 03:48:34 INFO - Type: GPU 03:48:34 INFO - Bus: Built-In 03:48:34 INFO - VRAM (Dynamic, Max): 1536 MB 03:48:34 INFO - Vendor: Intel (0x8086) 03:48:34 INFO - Device ID: 0x0a2e 03:48:34 INFO - Revision ID: 0x0009 03:48:34 INFO - Displays: 03:48:34 INFO - Display: 03:48:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:48:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:48:34 INFO - Display Serial Number: 1600x1200 60 03:48:34 INFO - Main Display: Yes 03:48:34 INFO - Mirror: Off 03:48:34 INFO - Online: Yes 03:48:34 INFO - Rotation: Supported 03:48:34 INFO - Return code: 0 03:48:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:48:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:48:34 INFO - Python 2.7.3 03:48:34 INFO - Return code: 0 03:48:34 INFO - grabbing minidump binary from tooltool 03:48:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:48:34 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 0x10db7bd30>, '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 0x10d9a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db73b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:48:34 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 03:48:34 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 03:48:34 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 03:48:34 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:48:34 INFO - Return code: 0 03:48:34 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:48:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:48:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:48:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:48:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:48:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Eb-HMLHIRC6RXE5ppQbLyw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0262', '--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 03:48:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Eb-HMLHIRC6RXE5ppQbLyw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0262 --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 03:48:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1Lbz7SntsU/Render', 03:48:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:48:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:48:34 INFO - 'HOME': '/Users/cltbld', 03:48:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:48:34 INFO - 'LOGNAME': 'cltbld', 03:48:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:48:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:48:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:34 INFO - 'MOZ_NO_REMOTE': '1', 03:48:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:48:34 INFO - 'NO_EM_RESTART': '1', 03:48:34 INFO - 'PAGER': '/bin/cat', 03:48:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:48:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:34 INFO - 'PWD': '/builds/slave/test', 03:48:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:48:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:48:34 INFO - 'SHELL': '/bin/bash', 03:48:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FJI4NFwUdF/Listeners', 03:48:34 INFO - 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/', 03:48:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:48:34 INFO - 'USER': 'cltbld', 03:48:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:48:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:48:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:34 INFO - 'XPC_FLAGS': '0x0', 03:48:34 INFO - 'XPC_SERVICE_NAME': '0', 03:48:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:48:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Eb-HMLHIRC6RXE5ppQbLyw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0262', '--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 03:48:35 INFO - mozversion application_buildid: 20161004001902 03:48:35 INFO - mozversion application_changeset: f927dc3ad86478c7b54507fa8cf862cff4f372b4 03:48:35 INFO - mozversion application_display_name: Nightly 03:48:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:48:35 INFO - mozversion application_name: Firefox 03:48:35 INFO - mozversion application_remotingname: firefox 03:48:35 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 03:48:35 INFO - mozversion application_vendor: Mozilla 03:48:35 INFO - mozversion application_version: 52.0a1 03:48:35 INFO - mozversion platform_buildid: 20161004001902 03:48:35 INFO - mozversion platform_changeset: f927dc3ad86478c7b54507fa8cf862cff4f372b4 03:48:35 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 03:48:35 INFO - mozversion platform_version: 52.0a1 03:48:35 INFO - using testdate: 1475578115 03:48:35 INFO - actual date: 1475578115 03:48:35 INFO - starting webserver on 'localhost:49271' 03:48:35 INFO - SUITE-START | Running 2 tests 03:48:35 INFO - TEST-START | dromaeo_css 03:48:35 INFO - operating with platform_type : mac_ 03:48:35 INFO - Initialising browser for dromaeo_css test... 03:48:35 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/tmp_Xjg3P/profile http://localhost:49271/getInfo.html) 03:48:37 INFO - PROCESS | 1652 | 2016-10-04 03:48:37.891 plugin-container[1654:7697] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f37, name = 'com.apple.tsm.portname' 03:48:37 INFO - PROCESS | 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:48:37 INFO - PROCESS | 1652 | 2016-10-04 03:48:37.894 plugin-container[1654:7697] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x910f, name = 'com.apple.CFPasteboardClient' 03:48:37 INFO - PROCESS | 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:48:37 INFO - PROCESS | 1652 | 2016-10-04 03:48:37.894 plugin-container[1654:7697] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:48:37 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 03:48:37 INFO - PROCESS | 1652 | colorDepth:24 03:48:37 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 03:48:37 INFO - PROCESS | 1652 | __metrics 03:48:38 ERROR - PROCESS | 1652 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3079: TypeError: this.tabs is undefined 03:48:38 INFO - TEST-INFO | 1652: exit 0 03:48:38 INFO - Browser initialized. 03:48:38 INFO - Running cycle 1/1 for dromaeo_css test... 03:48:38 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/tmp_Xjg3P/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:48:41 INFO - PROCESS | 1655 | 2016-10-04 03:48:41.748 plugin-container[1656:7817] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b1f, name = 'com.apple.tsm.portname' 03:48:41 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:48:41 INFO - PROCESS | 1655 | 2016-10-04 03:48:41.751 plugin-container[1656:7817] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9003, name = 'com.apple.CFPasteboardClient' 03:48:41 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:48:41 INFO - PROCESS | 1655 | 2016-10-04 03:48:41.751 plugin-container[1656:7817] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:48:51 INFO - PROCESS | 1655 | RSS: Main: 240533504 03:48:51 INFO - PROCESS | 1655 | 03:49:40 INFO - PROCESS | 1655 | 1475578180833 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:51:53 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 03:51:55 INFO - PROCESS | 1655 | RSS: Main: 257204224 03:51:55 INFO - PROCESS | 1655 | 03:54:57 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 03:54:58 INFO - PROCESS | 1655 | RSS: Main: 265814016 03:54:58 INFO - PROCESS | 1655 | 03:57:59 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 03:58:00 INFO - PROCESS | 1655 | RSS: Main: 270508032 03:58:00 INFO - PROCESS | 1655 | 04:01:02 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 04:01:03 INFO - PROCESS | 1655 | RSS: Main: 270270464 04:01:03 INFO - PROCESS | 1655 | 04:04:06 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 04:04:06 INFO - PROCESS | 1655 | RSS: Main: 276668416 04:04:06 INFO - PROCESS | 1655 | 04:07:09 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 04:07:09 INFO - PROCESS | 1655 | RSS: Main: 280457216 04:07:09 INFO - PROCESS | 1655 | 04:07:09 INFO - PROCESS | 1655 | __start_tp_report 04:07:09 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 04:07:09 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 04:07:09 INFO - PROCESS | 1655 | |i|pagename|runs| 04:07:09 INFO - PROCESS | 1655 | |0;dojo.html;2824.632797736295;2872.339361946752;3129.6870312968704;3236.352729454108;3270.771046026779;5134.948650513494;5479.232907392963;5529.115341545354;5554.1391084381885;5555.416681248466;5422.810201642943;5464.972675136629;5494.2857428534235;5525.972370138154;5584.52531534819;4990.27640992056;5003.199488081917;5064.822731204408;5124.0776660201145;5124.948750512484;5037.59699224063;5095.184770436731;5122.206058061007;5146.974265128669;5173.30160428343;4953.083679519301;4977.676451030671;5074.188129899217;5110.029094472038;5135.871603209912;5038.370203724535;5049.924251136236;5071.2139618359215;5072.670276432057;5097.23541468779;4983.6760610560195;4988.925166122511;5057.645964782467;5063.620228482879;5064.797408103672;5302.575793936476;5363.115086010804;5373.408925018245;5402.324709411324;5433.592480563973;5993;5993.130996005599;6001.819945401645;6035.78874739382;6072.119542666289;6076.392360763933;6133.570650054498;6138.355472675394;6143.938560614426;6195.938040619581;5488.588355873326;5555.444455554412;5647.729260916302;5660.462256085706;5672.177534257509;6136.140940268366;6151.83115208109;6161.84595385119;6189.473894718909;6221.96889015552;5956.55325850563;5976.223090998143;5983.338794396016;6010.519158467312;6071.878562428727;6044.879102417927;6088;6132.141500189977;6165.784197553064;6173.166622505994;5829.125631155361;5963.5825492216;5989.700514974234;6034.63792172471;6134.4172303631085;6075.058365953284;6084.148219249309;6091.08633704939;6111.144439778434;6113.5414843886;4730.692504987233;4813.663043586986;4817.686850354716;4836.322914791932;4867.586255168279;4238.830446782094;4261.126469073833;4271.145770845781;4288.849890253826;4330.545292744279;5500.22996780451;5532.612717109763;5563.36021357541;5571.888562228733;5646.6894320811925;5269.420363759983;6035.969820150871;6073.4837538808815;6077.270727512727;6090.147379366892;4603.49361570227;5399.6490228135835;5497.890042199134;5557.5831812613405;5574.498295153456;5235.947640523546;5262.184361423985;5263.605229607795;5281.15501519755;5284.101702710548;6164.907526387108;6169.444749972524;6189.50483961282;6211.782587609412;6221.9377806221355;4885.364902562644;5923.7926672566255;5993.220881285405;6119.051547010221;6164.198654174928;5025;5093.923591146062;6175.197224360804;6211.223597050369;6240.157578726814;4566.543345665407;5852.590318677651;6006.399360064133;6011.248593925759;6021.2473440819895;5758.1362795579325;5984.790532331347;5994.970025149846;6104.664243466652;6166.414190651881;5915.497182739343;5927.585069045125;5943;5960.791372302122;6029.57792954489;5855.414458554111;5889.5582831286965;5894.381089985662;5904.468597826216;5918.940810591839;5568.303962004749;5600.299962504687;5610.158476228598;5734.7132643368495;5749.741261643319;5845.357010728731;5882.705864706833;5896.911546326723;5913.793017244376;5915.201447804491;5727.8568035799435;5735.655860648374;5756.16535602327;5762.913556296743;5792.623479473821 04:07:09 INFO - PROCESS | 1655 | |1;ext.html;487.6220928780195;510.5150107397972;516.8449465160451;518.8313798015646;526.7892842862856;42414.36378454322;44016.779916100415;44188;44262.778686106525;44359.556404435985;43605.78197109018;43675;43742.56257437425;43858.56141438585;44058.77970610143;9862.457564833949;10060.245481588874;10075.848862267072;10079.949600251988;10090.596376144946;9788.021197880225;9793.16758075561;9892.455914924676;9896.653617123402;9898.455584942825;9704.902950970505;9787.902120978806;9795.853062204036;9910.603575856992;9927.354721943051;8299.419040667126;9821.950890245575;9849.753756156118;9857.162141218005;9880.011998800135;9761.316707830454;9802.950985245028;9864.654737084167;9878.90121098787;9890.554925028391;40719.796401017804;40862.38706419406;41280.79359603183;41351.966200844916;41361.379579306034;2699.452091407185;3286.507023946427;3328.5340052392444;3679.8712045078296;4081.346984482498;31090.378192436252;31393.744250229964;31525.054248372584;31774.682253177405;32354.19114522132;3024.0625406124173;3055.236190952262;3060.7704422168426;3129.1707697460192;3149.5275708643885;414245;427181;430419;432032;436878.9999999968;49779.502204977485;52890;59871.40128598658;60917;64314.8195367309;51004.979900401784;61497;62209;62326.0651090234;63301.68349158225;16281;16354.264058117413;16515.33938642465;16527.008379497267;16535.421260255833;11315.660530184108;12596.55912043074;12708.364581770875;12813.487460501476;12825.23048617086;14842.40630374773;16124.67750645004;17349.7397539037;17369.47891563255;17391.956482611084;6057.303410107806;6576.8819300719;6795.456363490909;6930.272321406281;6975.8604827903155;862.7584276402617;919.9264058875274;925.421611492817;1021.5096753558186;1052.9420881851418;29304.85347573291;30214.395712085636;30416.695833041827;30421.39157216843;30760.271176991926;966.9758256043655;1051.6003918510917;1060.2684147937898;1117.80997230471;1203.3381640097912;14982.250887455584;15688.843111568738;15795.025621797275;15886.52340429789;16035.839641603434;598289;600110;600754;602815;608656;57453;57623.71188144032;58381.41618583845;58594;58679;1278.520554791953;1321.0158431968052;1321.557278311757;1327.5419980106847;1334.4462048249868;29450.852745736134;30208.24479387945;30397.088087357413;30458.61175372628;30756.692433075383;35034;42467.787661062735;50900.745496272284;51308.74345628248;51500.227496586835;382916;552994;560541;561130;561429;40909.590904090575;41165.44266523981;41700.79149604232;41821.53624623123;41824.79087604542;46638.76680616575;47194.52805472039;47449.76275118603;48472.757636211594;48527.75736121297;38694.6130538691;38711.7625999444;39573;39980.400293996194;40264.396034058926;34114.14714632154;36510.63489365072;38437.03907402337;39327.41008884926;39819.80090099531;38512.6148738509;38695.6130438692;39505.80247098746;39569.406458903715;40970;31003.844980774953;33447.83276083604;34432.45053972527;35440;35458.822705886305;24405.755942440348;24774.38064048413;26094.73905260923;26132.8693356532;26566.203013909613 04:07:09 INFO - PROCESS | 1655 | |2;jquery.html;313.7129526483268;367.3552914634817;367.9981600092;379.59383459698137;397.5825383347486;19590.314338998138;20421.28525501604;20546.794532054675;20830.583388332223;21074.262400815973;19854.106565204565;20054;20199;20255.797442025574;20873.895630521863;5583.190437386576;5859.560532960024;5886.264216972879;6154.076888466721;6157.815265542018;3823.025128592219;5923.08192230205;5967.04527275636;5971.014782560872;5971.701414929258;3983;5876.764929402819;6147.139400483936;6195.81412557624;6220.502359811204;5846.766129354842;5966.97016514919;6028.939710602882;6185.041318595625;6194.597351172182;5617.0731829248125;5652.886942261173;5742.799002034951;5783.62406443584;5825.0679891217205;10391.740206494822;12874.678133046655;23048.11898512686;24977.250682479556;25491.362715932064;1979.4358607796853;2276.578832915916;2388.773066558674;2557.9104731334314;2774.7780177585946;9678.806423871483;9777.262945561426;9854.16239619626;10177.949110254476;10251.282410231286;1420.9076410033417;1675.0201132337597;1842.68674325365;1864.9627007459774;1895.3271588585992;103928.44107338396;110990;112092;116546;119071.4046429771;11279.92840680134;11332.660020199408;11401.543938242377;11620.825687614693;11681.532738690357;14226.14643121416;14396.064255823338;14416.207108608918;14441.422343106367;14443.06120102211;8075.878861817077;8367.330613551023;8384;8457.619407126695;8502;8228.753137405887;8260.793480163044;8321.209485098905;8369.49783013021;8436.367272454469;4418.690691651618;4451.376807246988;4482.955170448254;4583.610393116623;4594.609458196024;1584.7860538827342;1903.1435853865817;1933.4489670443857;1943.9805601944083;2014.6071516054521;799.9480033797785;817.5666896544841;853.2406158518924;865.9177378149066;884.255504342146;20585.176592936114;21221;21408.892955535124;21584.352469425943;21602.891985539973;821.8931538900024;896.3635818568889;975.6536429567401;990.3513198854762;1016.9593216271414;9914.752131196778;10022.498875056219;10386.688399348031;11443.313401195956;11528.942355288169;550966;556500;557153;594960;598277;117667;125561;127074.0938885899;128086.35956820156;128575;937.3157594955584;937.7843096087802;968.5399435268332;969.486172328667;969.6606187834343;18828.811711882707;19027.858328500333;19150.04249787533;19266;19417.417477475698;41455.7927210362;52542.161024363966;55366.72316638552;55462.613434664454;55475.722621388246;77087.61456192684;77329.2267077322;78871.81692274506;79107.4178516438;79446.6027669858;7167.104111986002;7173.282671732785;7349.265073492608;7391.926080739124;7539.849203016019;10545;12720.422454596819;12904.8064279034;12969.54606588765;12992.480300787862;9252.907470925475;9958.900410995797;10811.405372704263;11164.609238676607;11194.384308863091;10792;10834;10834.729131771768;11187.664370068911;11393.974542291233;10691.939002132056;10924.563017479211;11273.323600583992;11461.369624670722;11752.823707644222;8125.959370203112;8179.63191656365;8273.46222495536;8343.41596088268;8454.746357609281;8820.647174112964;11079.556817727524;11275.548978041115;11416.200865939636;11734 04:07:09 INFO - PROCESS | 1655 | |3;mootools.html;1540.6533529955757;1561.898476599021;1694.5848267174536;1798.1998010885154;1856.4523465577654;8017.719379821693;8268.173182681729;8656.826863462727;9281.99999999999;9296.674616388427;8701.869471957925;9003.594838232279;9107.180353768159;9143.77140571486;9144.862827057583;1970.9356947248468;2369.6208606622945;2395.7244916834525;2400.099962514057;2405.170216275391;2035.4911272181955;2352.235523454884;2376.4534157143867;2388.916387926423;2399.9640005399847;2250.2011785816044;2252.583272094668;2259.2092767531317;2267.954640907181;2274.647429648407;2282.2468585366787;2347.9765202348012;2356.2931120663816;2358.3750306168877;2362.350353652742;2293.7591552886875;2295.185209250709;2299.482616411311;2299.6435552489393;2304.043821813945;9100.453972761656;9157.77105572366;9207.802985611894;9212.815743685156;9236.5843537041;4909.509049095098;5048.268001139851;5061.822836200715;5091.05815424144;5107.182850743863;3431.811250381228;3517.771344862576;3636.3999940009867;3657.4696668983115;3662.176010397666;1025.2054657640315;1047.9161667066617;1062.7130674717782;1077.1544337694872;1084.8860869608657;11592.188546801643;12102.334371609559;12151.453184606715;12253.754924901541;12271.754564908651;4607.3319368691355;4642.535746425398;4848.660593758474;4888.437829649564;4892.217245240744;10145.695629131138;10164.0344167304;10248.795024099476;10256.076953074109;10294.970502949795;5297.443768404339;5374.704391258519;5389.218563308376;5390.54180394663;5399.920015996817;4411.691181617321;4545.704529205591;4696.7651617419;4846.273059041101;4964.404271487372;3958.6239307265764;3982.3230050891416;3997.8600748974227;4099.262132816122;4111.198316328288;1288.1755676367131;1297.2475963940892;1304.8303720516271;1309.463120120746;1309.7511472820133;918.4030380252889;923.35826600512;938.8122375524922;953.5934496617434;972.1833659725722;5829.562782791223;6009;6106.9083963739695;6155.230596175478;6172.321044685081;384.41952651496445;431.39604553625173;441.0737451352199;444.6842741653462;457.4373520569718;4004.8598299059395;4030.6170913763144;4062.370332598452;4115.176964607031;4116.279651061112;10777.299475534066;11047.944760276308;11228.606998755167;11250.987411133037;11252.831207531894;11127.944360278309;11197.888021119847;11204.215704900578;11221.326720396639;11268.71828204285;8394.412391132684;8441.198086181803;8490.49057056591;8502.14978502145;8504.192101750325;5781.219535362672;5976.9103463448955;6036.9698151508965;6070.514358851369;6114.357992410733;9754.463504507321;10291.94854025725;10327.741806454898;10336;10431.269811113149;10268.127209187003;10461.738456538647;10474.68575942723;10489.423081730578;10495.317804342692;6403.679816009274;6591.406773390418;7162.713491460283;7493.550386976799;7502.512336698097;7988.920110798817;8543.145685431657;8546.871796922927;8553.786155346166;8565.05784363732;7198.89201661965;7337.376323012603;7345.742898998509;7349.853002939804;7481.401487881065;6575.572587781779;7281.344678978918;7424.294692004251;7529.134149572869;7533.924660753322;6229.719662615103;6264.49884009269;6971.198312193959;7095.290470952863;7097.46768992338;4328.9134217316105;5043.823466178666;5069.112905241642;5084.008618319393;5120.590352771695;4983.875403114806;5051.823186188466;5079.111155547838;5095.031943930641;5104.872378190575 04:07:09 INFO - PROCESS | 1655 | |4;prototype.html;258.5823894410527;259.7208001398497;275.3254526410295;295.3811764353678;310.39473027596193;4917.360743103396;5415.431379705134;5591.524720398766;5673.404292549274;5688.374278829326;4506.526814684452;4919.139150648631;5288.096285337285;5316.680999140054;5420.539254163391;4191.889149375418;4218.493780746299;4266.33354153654;4274.166537525184;4281.422008028907;4152.792360381984;4175.812088456027;4231.209218517562;4265.914681706379;4289.2334444283415;4169.499660040799;4187.539370669239;4206.642435392995;4216.430781844442;4219.303814870543;4233.470816147981;4238.660907127453;4242.724222925531;4257.14857028594;4270.722403043807;3534.8688419705704;3649.7627654202392;3659.396199627058;3669.7798132112157;3712.7215458840697;4466.280482014447;4713.858584242478;5428.728563571845;5454.809081682161;5473.0969390050595;4045.271851066807;4846.079244943449;4852.636052296092;4855.660103792736;4857.222844344888;5585.273914391103;5637.802676906289;5780.786034932669;5814.418558144194;5891.705414729289;3367.9831600842085;3955.307821131319;3966.5636779954184;3971.590085519628;3987.521497420328;4924.753762311906;5485.506304432581;5640.266765320482;5690.06113991191;6099.390060993909;3540.831525596547;3596.5324507813816;3704.388775852008;3914.825552334288;4025.355943049098;3151.5115157150676;3158.368326334742;3201.6158061032825;3756.3050835594954;3967.6230758077936;4050.736702114353;4155.8753237402925;4387.692861499728;4687.062587482517;4940.258961155783;5900.8399078649445;5922.822315330547;5954.523638108941;5975.4007006952115;5981.7607295707685;1319.4392383237277;1371.2184055088703;1372.2315503318173;1395.0304538345956;1403.8207905359548;773.1765669561898;938.7467730579616;958.3866325551653;964.7781010367514;966.2270183852889;4622.491525932145;5516.558675305966;5538.587660146637;5546.64588298184;5634.140733557998;6001;6006.939930600638;6016.998695867287;6071.574989750675;6085.726142323606;4927.90144197114;5169.663971841894;5482.205080263339;5486.478784515464;5624.0439125348785;2359.6314137800036;2638.5118753030365;2670.1588999465107;2676.9024699872957;2734.293049880604;4330.783460826946;4464.955350446519;4728.243481043017;4940.2342636891335;5139.563137133386;4330.653547716175;4351.369051487517;4778.761061946958;5062.595267248102;5305;6139.899350827893;6303.873922521616;6319.368063193736;6367.331430199855;6367.968160159169;5376.516113549799;5431.8098866539485;5680.829575112753;6160.784372546939;6162.907556386747;5344.514800617731;6008.218931538872;6041.516678665784;6041.758329666764;6100.0849872519475;5103.387593488656;5960.642361458326;6016.608920420159;6364.236291644847;6430.035494675836;3753.024213704402;3960.4257382679925;3981.5421226559315;4005.9399109012807;4015.9799201003807;5296.258523806593;5764.538836893123;6029.969850150721;6039.698015099315;6116.3883611638485;5246.475352464723;5804.303483581997;5977.535503801597;5998.700064996646;6001.129836173817;5371.40914499397;5945.791897283574;5952.642841429528;5991.7603295867675;6004.39956004396;5262;5623.493885550321;5815.244018277597;5827.854303642443;5891.967271291398;4924.482929292516;5673.943260567342;5806.838632273647;5888.3228428729535;5904.232449781501;4399.362092496634;4692.906141877212;4958.776855041459;5397.460253974571;5531.751071201725 04:07:09 INFO - PROCESS | 1655 | |5;yui.html;734.79425760787;747.2415498269256;750.9924900750991;789.6249281591241;819.8931442552553;14878.851211487896;14923.701525969474;15969.680606387865;15990.200489975497;16010.839891601081;14335.139891606512;14572.417103315882;14638.634034149152;14646;14658.560243192722;669.7689297192461;688.9207741109786;849.155090684768;876.8158686675806;878.0473186592554;843.9324854011695;860.1312674199041;872.8428882801094;873.5108339329964;875.9737207883742;874.0778478704964;876.3733930239878;893.4817805672727;923.007766650853;926.2913870888775;898.3935843305743;908.8818453601056;913.7121806630923;913.980911283917;917.5779141594875;658.4633523678187;680.45223595006;681.9352161544646;682.0621645237798;682.5154140560159;14033.929830350886;14355.210463424508;14372.64068398288;14559.272036398244;14577.70844583113;14373.568792936125;14419.78370324446;14453.927730361385;14704.632384190374;14790.260486975716;11934.641960741192;11970.82043769344;11980.58067967617;12030.759384812254;12035.628076192963;3763.435484677293;3826.2921359548295;3828.942565861514;3880.9029774255587;3945.2898478274187;114831;118667.406662967;118735.2189717155;119689;120100;11172.273802202993;11226.438678066064;11264.774704505864;11278.436078196057;11409.885901140882;19009.524761880788;19338.03309834531;19785.901070494554;22646.320610381714;22858.542829143324;6698.866022679519;7270.418366530771;7489.887651685229;8116.715914942949;8206.302464290602;3896.7661940283674;4185.518665353462;4198.202341555095;4273.743575385487;4384.517703052662;3428.280061187129;3557.0573797943566;3558.2705545363137;3558.288342331544;3576.445650924111;645.3546453546453;646.8221239159175;666.2171947961126;667.2093569120608;673.4275865514371;536.841631718644;589.4400319696306;604.3503234023442;634.1388026143193;644.7711062572719;8926.821463570823;9010.831040721712;9030.593623286968;9057.77355566116;9112.134347237003;536.4045909040962;588.608575297431;624.6002558362652;625.2528228766671;625.7403177681211;4207.179599978036;4362.124286556747;4391.626711729475;4445.644348452116;4461.930522644971;167280;169118.30881691273;170970;172474;174747;117052;117378.41310793562;119325.80674193321;130249;142632;30798.230044248627;31896;32033;33969.49045764316;110474;9650.758731031781;9747.561359738687;9977.800443991226;10036.799264014533;10303.278770485995;47836.760816195696;53347.19979200393;58263.70868145632;65943.67028164829;66480.33519664935;92851;95401;96230.51884740531;96696;98511;12784.360781960679;12906.80639790385;13045.608631741063;13123.60629181126;13135.146215495963;14401.567952961428;14668.55994320172;14814.62963425923;15185.316660750514;15322.387104515694;13359.666008349868;13511.391987360788;13645;13667.111637743516;13891.235982021086;13354.131981421177;13742.312884355943;13810.10234334765;14136.78794818099;14221.075630084011;13459.932700336436;13553.661158471117;13642.795358069437;13763.449462021406;13783.173009619455;11015.669529914116;11119.555217791198;11131.610393636183;11512.654620361403;11691.532338706356;10345.482725863827;10495.609465694239;10992.418162513279;11659.18385712992;11697.824532632187 04:07:09 INFO - PROCESS | 1655 | __end_tp_report 04:07:09 INFO - PROCESS | 1655 | __start_cc_report 04:07:09 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,354 04:07:09 INFO - PROCESS | 1655 | __end_cc_report 04:07:09 INFO - PROCESS | 1655 | __startTimestamp1475579229759__endTimestamp 04:07:09 INFO - PROCESS | 1655 | 04:07:09 INFO - PROCESS | 1655 | ------- Summary: start ------- 04:07:09 INFO - PROCESS | 1655 | Number of tests: 6 04:07:09 INFO - PROCESS | 1655 | 04:07:09 INFO - PROCESS | 1655 | [#0] dojo.html Cycles:165 Average:5533.57 Median:5672.18 stddev:658.15 (11.6%) stddev-sans-first:624.92 04:07:09 INFO - PROCESS | 1655 | Values: 2824.6 2872.3 3129.7 3236.4 3270.8 5134.9 5479.2 5529.1 5554.1 5555.4 5422.8 5465.0 5494.3 5526.0 5584.5 4990.3 5003.2 5064.8 5124.1 5124.9 5037.6 5095.2 5122.2 5147.0 5173.3 4953.1 4977.7 5074.2 5110.0 5135.9 5038.4 5049.9 5071.2 5072.7 5097.2 4983.7 4988.9 5057.6 5063.6 5064.8 5302.6 5363.1 5373.4 5402.3 5433.6 5993.0 5993.1 6001.8 6035.8 6072.1 6076.4 6133.6 6138.4 6143.9 6195.9 5488.6 5555.4 5647.7 5660.5 5672.2 6136.1 6151.8 6161.8 6189.5 6222.0 5956.6 5976.2 5983.3 6010.5 6071.9 6044.9 6088.0 6132.1 6165.8 6173.2 5829.1 5963.6 5989.7 6034.6 6134.4 6075.1 6084.1 6091.1 6111.1 6113.5 4730.7 4813.7 4817.7 4836.3 4867.6 4238.8 4261.1 4271.1 4288.8 4330.5 5500.2 5532.6 5563.4 5571.9 5646.7 5269.4 6036.0 6073.5 6077.3 6090.1 4603.5 5399.6 5497.9 5557.6 5574.5 5235.9 5262.2 5263.6 5281.2 5284.1 6164.9 6169.4 6189.5 6211.8 6221.9 4885.4 5923.8 5993.2 6119.1 6164.2 5025.0 5093.9 6175.2 6211.2 6240.2 4566.5 5852.6 6006.4 6011.2 6021.2 5758.1 5984.8 5995.0 6104.7 6166.4 5915.5 5927.6 5943.0 5960.8 6029.6 5855.4 5889.6 5894.4 5904.5 5918.9 5568.3 5600.3 5610.2 5734.7 5749.7 5845.4 5882.7 5896.9 5913.8 5915.2 5727.9 5735.7 5756.2 5762.9 5792.6 04:07:09 INFO - PROCESS | 1655 | 04:07:09 INFO - PROCESS | 1655 | [#1] ext.html Cycles:180 Average:66374.70 Median:41223.12 stddev:139773.55 (339.1%) stddev-sans-first:140078.11 04:07:09 INFO - PROCESS | 1655 | Values: 487.6 510.5 516.8 518.8 526.8 42414.4 44016.8 44188.0 44262.8 44359.6 43605.8 43675.0 43742.6 43858.6 44058.8 9862.5 10060.2 10075.8 10079.9 10090.6 9788.0 9793.2 9892.5 9896.7 9898.5 9704.9 9787.9 9795.9 9910.6 9927.4 8299.4 9822.0 9849.8 9857.2 9880.0 9761.3 9803.0 9864.7 9878.9 9890.6 40719.8 40862.4 41280.8 41352.0 41361.4 2699.5 3286.5 3328.5 3679.9 4081.3 31090.4 31393.7 31525.1 31774.7 32354.2 3024.1 3055.2 3060.8 3129.2 3149.5 414245.0 427181.0 430419.0 432032.0 436879.0 49779.5 52890.0 59871.4 60917.0 64314.8 51005.0 61497.0 62209.0 62326.1 63301.7 16281.0 16354.3 16515.3 16527.0 16535.4 11315.7 12596.6 12708.4 12813.5 12825.2 14842.4 16124.7 17349.7 17369.5 17392.0 6057.3 6576.9 6795.5 6930.3 6975.9 862.8 919.9 925.4 1021.5 1052.9 29304.9 30214.4 30416.7 30421.4 30760.3 967.0 1051.6 1060.3 1117.8 1203.3 14982.3 15688.8 15795.0 15886.5 16035.8 598289.0 600110.0 600754.0 602815.0 608656.0 57453.0 57623.7 58381.4 58594.0 58679.0 1278.5 1321.0 1321.6 1327.5 1334.4 29450.9 30208.2 30397.1 30458.6 30756.7 35034.0 42467.8 50900.7 51308.7 51500.2 382916.0 552994.0 560541.0 561130.0 561429.0 40909.6 41165.4 41700.8 41821.5 41824.8 46638.8 47194.5 47449.8 48472.8 48527.8 38694.6 38711.8 39573.0 39980.4 40264.4 34114.1 36510.6 38437.0 39327.4 39819.8 38512.6 38695.6 39505.8 39569.4 40970.0 31003.8 33447.8 34432.5 35440.0 35458.8 24405.8 24774.4 26094.7 26132.9 26566.2 04:07:09 INFO - PROCESS | 1655 | 04:07:09 INFO - PROCESS | 1655 | [#2] jquery.html Cycles:180 Average:33825.08 Median:367.68 stddev:95565.62 (25991.8%) stddev-sans-first:95800.58 04:07:09 INFO - PROCESS | 1655 | Values: 313.7 367.4 368.0 379.6 397.6 19590.3 20421.3 20546.8 20830.6 21074.3 19854.1 20054.0 20199.0 20255.8 20873.9 5583.2 5859.6 5886.3 6154.1 6157.8 3823.0 5923.1 5967.0 5971.0 5971.7 3983.0 5876.8 6147.1 6195.8 6220.5 5846.8 5967.0 6028.9 6185.0 6194.6 5617.1 5652.9 5742.8 5783.6 5825.1 10391.7 12874.7 23048.1 24977.3 25491.4 1979.4 2276.6 2388.8 2557.9 2774.8 9678.8 9777.3 9854.2 10177.9 10251.3 1420.9 1675.0 1842.7 1865.0 1895.3 103928.4 110990.0 112092.0 116546.0 119071.4 11279.9 11332.7 11401.5 11620.8 11681.5 14226.1 14396.1 14416.2 14441.4 14443.1 8075.9 8367.3 8384.0 8457.6 8502.0 8228.8 8260.8 8321.2 8369.5 8436.4 4418.7 4451.4 4483.0 4583.6 4594.6 1584.8 1903.1 1933.4 1944.0 2014.6 799.9 817.6 853.2 865.9 884.3 20585.2 21221.0 21408.9 21584.4 21602.9 821.9 896.4 975.7 990.4 1017.0 9914.8 10022.5 10386.7 11443.3 11528.9 550966.0 556500.0 557153.0 594960.0 598277.0 117667.0 125561.0 127074.1 128086.4 128575.0 937.3 937.8 968.5 969.5 969.7 18828.8 19027.9 19150.0 19266.0 19417.4 41455.8 52542.2 55366.7 55462.6 55475.7 77087.6 77329.2 78871.8 79107.4 79446.6 7167.1 7173.3 7349.3 7391.9 7539.8 10545.0 12720.4 12904.8 12969.5 12992.5 9252.9 9958.9 10811.4 11164.6 11194.4 10792.0 10834.0 10834.7 11187.7 11394.0 10691.9 10924.6 11273.3 11461.4 11752.8 8126.0 8179.6 8273.5 8343.4 8454.7 8820.6 11079.6 11275.5 11416.2 11734.0 04:07:09 INFO - PROCESS | 1655 | 04:07:09 INFO - PROCESS | 1655 | [#3] mootools.html Cycles:180 Average:5778.13 Median:2501.57 stddev:3336.80 (133.4%) stddev-sans-first:3330.97 04:07:09 INFO - PROCESS | 1655 | Values: 1540.7 1561.9 1694.6 1798.2 1856.5 8017.7 8268.2 8656.8 9282.0 9296.7 8701.9 9003.6 9107.2 9143.8 9144.9 1970.9 2369.6 2395.7 2400.1 2405.2 2035.5 2352.2 2376.5 2388.9 2400.0 2250.2 2252.6 2259.2 2268.0 2274.6 2282.2 2348.0 2356.3 2358.4 2362.4 2293.8 2295.2 2299.5 2299.6 2304.0 9100.5 9157.8 9207.8 9212.8 9236.6 4909.5 5048.3 5061.8 5091.1 5107.2 3431.8 3517.8 3636.4 3657.5 3662.2 1025.2 1047.9 1062.7 1077.2 1084.9 11592.2 12102.3 12151.5 12253.8 12271.8 4607.3 4642.5 4848.7 4888.4 4892.2 10145.7 10164.0 10248.8 10256.1 10295.0 5297.4 5374.7 5389.2 5390.5 5399.9 4411.7 4545.7 4696.8 4846.3 4964.4 3958.6 3982.3 3997.9 4099.3 4111.2 1288.2 1297.2 1304.8 1309.5 1309.8 918.4 923.4 938.8 953.6 972.2 5829.6 6009.0 6106.9 6155.2 6172.3 384.4 431.4 441.1 444.7 457.4 4004.9 4030.6 4062.4 4115.2 4116.3 10777.3 11047.9 11228.6 11251.0 11252.8 11127.9 11197.9 11204.2 11221.3 11268.7 8394.4 8441.2 8490.5 8502.1 8504.2 5781.2 5976.9 6037.0 6070.5 6114.4 9754.5 10291.9 10327.7 10336.0 10431.3 10268.1 10461.7 10474.7 10489.4 10495.3 6403.7 6591.4 7162.7 7493.6 7502.5 7988.9 8543.1 8546.9 8553.8 8565.1 7198.9 7337.4 7345.7 7349.9 7481.4 6575.6 7281.3 7424.3 7529.1 7533.9 6229.7 6264.5 6971.2 7095.3 7097.5 4328.9 5043.8 5069.1 5084.0 5120.6 4983.9 5051.8 5079.1 5095.0 5104.9 04:07:09 INFO - PROCESS | 1655 | 04:07:09 INFO - PROCESS | 1655 | [#4] prototype.html Cycles:180 Average:4633.35 Median:5121.48 stddev:1465.59 (28.6%) stddev-sans-first:1432.45 04:07:09 INFO - PROCESS | 1655 | Values: 258.6 259.7 275.3 295.4 310.4 4917.4 5415.4 5591.5 5673.4 5688.4 4506.5 4919.1 5288.1 5316.7 5420.5 4191.9 4218.5 4266.3 4274.2 4281.4 4152.8 4175.8 4231.2 4265.9 4289.2 4169.5 4187.5 4206.6 4216.4 4219.3 4233.5 4238.7 4242.7 4257.1 4270.7 3534.9 3649.8 3659.4 3669.8 3712.7 4466.3 4713.9 5428.7 5454.8 5473.1 4045.3 4846.1 4852.6 4855.7 4857.2 5585.3 5637.8 5780.8 5814.4 5891.7 3368.0 3955.3 3966.6 3971.6 3987.5 4924.8 5485.5 5640.3 5690.1 6099.4 3540.8 3596.5 3704.4 3914.8 4025.4 3151.5 3158.4 3201.6 3756.3 3967.6 4050.7 4155.9 4387.7 4687.1 4940.3 5900.8 5922.8 5954.5 5975.4 5981.8 1319.4 1371.2 1372.2 1395.0 1403.8 773.2 938.7 958.4 964.8 966.2 4622.5 5516.6 5538.6 5546.6 5634.1 6001.0 6006.9 6017.0 6071.6 6085.7 4927.9 5169.7 5482.2 5486.5 5624.0 2359.6 2638.5 2670.2 2676.9 2734.3 4330.8 4465.0 4728.2 4940.2 5139.6 4330.7 4351.4 4778.8 5062.6 5305.0 6139.9 6303.9 6319.4 6367.3 6368.0 5376.5 5431.8 5680.8 6160.8 6162.9 5344.5 6008.2 6041.5 6041.8 6100.1 5103.4 5960.6 6016.6 6364.2 6430.0 3753.0 3960.4 3981.5 4005.9 4016.0 5296.3 5764.5 6030.0 6039.7 6116.4 5246.5 5804.3 5977.5 5998.7 6001.1 5371.4 5945.8 5952.6 5991.8 6004.4 5262.0 5623.5 5815.2 5827.9 5892.0 4924.5 5673.9 5806.8 5888.3 5904.2 4399.4 4692.9 4958.8 5397.5 5531.8 04:07:09 INFO - PROCESS | 1655 | 04:07:09 INFO - PROCESS | 1655 | [#5] yui.html Cycles:180 Average:23900.11 Median:33001.25 stddev:40079.66 (121.4%) stddev-sans-first:40154.35 04:07:09 INFO - PROCESS | 1655 | Values: 734.8 747.2 751.0 789.6 819.9 14878.9 14923.7 15969.7 15990.2 16010.8 14335.1 14572.4 14638.6 14646.0 14658.6 669.8 688.9 849.2 876.8 878.0 843.9 860.1 872.8 873.5 876.0 874.1 876.4 893.5 923.0 926.3 898.4 908.9 913.7 914.0 917.6 658.5 680.5 681.9 682.1 682.5 14033.9 14355.2 14372.6 14559.3 14577.7 14373.6 14419.8 14453.9 14704.6 14790.3 11934.6 11970.8 11980.6 12030.8 12035.6 3763.4 3826.3 3828.9 3880.9 3945.3 114831.0 118667.4 118735.2 119689.0 120100.0 11172.3 11226.4 11264.8 11278.4 11409.9 19009.5 19338.0 19785.9 22646.3 22858.5 6698.9 7270.4 7489.9 8116.7 8206.3 3896.8 4185.5 4198.2 4273.7 4384.5 3428.3 3557.1 3558.3 3558.3 3576.4 645.4 646.8 666.2 667.2 673.4 536.8 589.4 604.4 634.1 644.8 8926.8 9010.8 9030.6 9057.8 9112.1 536.4 588.6 624.6 625.3 625.7 4207.2 4362.1 4391.6 4445.6 4461.9 167280.0 169118.3 170970.0 172474.0 174747.0 117052.0 117378.4 119325.8 130249.0 142632.0 30798.2 31896.0 32033.0 33969.5 110474.0 9650.8 9747.6 9977.8 10036.8 10303.3 47836.8 53347.2 58263.7 65943.7 66480.3 92851.0 95401.0 96230.5 96696.0 98511.0 12784.4 12906.8 13045.6 13123.6 13135.1 14401.6 14668.6 14814.6 15185.3 15322.4 13359.7 13511.4 13645.0 13667.1 13891.2 13354.1 13742.3 13810.1 14136.8 14221.1 13459.9 13553.7 13642.8 13763.4 13783.2 11015.7 11119.6 11131.6 11512.7 11691.5 10345.5 10495.6 10992.4 11659.2 11697.8 04:07:09 INFO - PROCESS | 1655 | -------- Summary: end -------- 04:07:09 INFO - PROCESS | 1655 | 04:07:10 INFO - TEST-INFO | 1655: exit 0 04:07:10 INFO - TEST-OK | dromaeo_css | took 1115369ms 04:07:10 INFO - TEST-START | kraken 04:07:10 INFO - operating with platform_type : mac_ 04:07:10 INFO - Initialising browser for kraken test... 04:07:10 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/tmpIZ_1Nx/profile http://localhost:49271/getInfo.html) 04:07:12 INFO - PROCESS | 1670 | 2016-10-04 04:07:12.987 plugin-container[1671:10010] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x471b, name = 'com.apple.tsm.portname' 04:07:12 INFO - PROCESS | 1670 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:07:12 INFO - PROCESS | 1670 | 2016-10-04 04:07:12.989 plugin-container[1671:10010] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9203, name = 'com.apple.CFPasteboardClient' 04:07:12 INFO - PROCESS | 1670 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:07:12 INFO - PROCESS | 1670 | 2016-10-04 04:07:12.989 plugin-container[1671:10010] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:07:13 INFO - PROCESS | 1670 | __metrics Screen width/height:1600/1200 04:07:13 INFO - PROCESS | 1670 | colorDepth:24 04:07:13 INFO - PROCESS | 1670 | Browser inner width/height: 1024/689 04:07:13 INFO - PROCESS | 1670 | __metrics 04:07:13 ERROR - PROCESS | 1670 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3079: TypeError: this.tabs is undefined 04:07:13 INFO - TEST-INFO | 1670: exit 0 04:07:13 INFO - Browser initialized. 04:07:13 INFO - Running cycle 1/1 for kraken test... 04:07:13 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/tmpIZ_1Nx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:07:16 INFO - PROCESS | 1672 | 2016-10-04 04:07:16.346 plugin-container[1673:10122] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b1b, name = 'com.apple.tsm.portname' 04:07:16 INFO - PROCESS | 1672 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:07:16 INFO - PROCESS | 1672 | 2016-10-04 04:07:16.349 plugin-container[1673:10122] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9203, name = 'com.apple.CFPasteboardClient' 04:07:16 INFO - PROCESS | 1672 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:07:16 INFO - PROCESS | 1672 | 2016-10-04 04:07:16.349 plugin-container[1673:10122] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:07:26 INFO - PROCESS | 1672 | RSS: Main: 240410624 04:07:26 INFO - PROCESS | 1672 | 04:07:29 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 04:07:29 INFO - PROCESS | 1672 | RSS: Main: 254197760 04:07:29 INFO - PROCESS | 1672 | 04:07:32 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 04:07:33 INFO - PROCESS | 1672 | RSS: Main: 261754880 04:07:33 INFO - PROCESS | 1672 | 04:07:36 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 04:07:37 INFO - PROCESS | 1672 | RSS: Main: 262414336 04:07:37 INFO - PROCESS | 1672 | 04:07:39 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 04:07:39 INFO - PROCESS | 1672 | RSS: Main: 264691712 04:07:39 INFO - PROCESS | 1672 | 04:07:41 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:07:42 INFO - PROCESS | 1672 | RSS: Main: 265056256 04:07:42 INFO - PROCESS | 1672 | 04:07:45 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 04:07:45 INFO - PROCESS | 1672 | RSS: Main: 265924608 04:07:45 INFO - PROCESS | 1672 | 04:07:48 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 04:07:49 INFO - PROCESS | 1672 | RSS: Main: 265764864 04:07:49 INFO - PROCESS | 1672 | 04:07:52 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 04:07:52 INFO - PROCESS | 1672 | RSS: Main: 266244096 04:07:52 INFO - PROCESS | 1672 | 04:07:54 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:07:55 INFO - PROCESS | 1672 | RSS: Main: 265957376 04:07:55 INFO - PROCESS | 1672 | 04:07:57 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:07:57 INFO - PROCESS | 1672 | RSS: Main: 266039296 04:07:57 INFO - PROCESS | 1672 | 04:07:59 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:08:00 INFO - PROCESS | 1672 | RSS: Main: 266006528 04:08:00 INFO - PROCESS | 1672 | 04:08:03 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:08:04 INFO - PROCESS | 1672 | RSS: Main: 266317824 04:08:04 INFO - PROCESS | 1672 | 04:08:07 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:08:08 INFO - PROCESS | 1672 | RSS: Main: 266637312 04:08:08 INFO - PROCESS | 1672 | 04:08:09 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 04:08:10 INFO - PROCESS | 1672 | RSS: Main: 267968512 04:08:10 INFO - PROCESS | 1672 | 04:08:10 INFO - PROCESS | 1672 | __start_tp_report 04:08:10 INFO - PROCESS | 1672 | _x_x_mozilla_page_load 04:08:10 INFO - PROCESS | 1672 | _x_x_mozilla_page_load_details 04:08:10 INFO - PROCESS | 1672 | |i|pagename|runs| 04:08:10 INFO - PROCESS | 1672 | |0;ai-astar;105;116;116;117;117;118;118;117;117;117 04:08:10 INFO - PROCESS | 1672 | |1;audio-beat-detection;151;115;118;151;116;118;120;120;171;117 04:08:10 INFO - PROCESS | 1672 | |2;audio-dft;201;208;218;197;201;197;196;199;202;194 04:08:10 INFO - PROCESS | 1672 | |3;audio-fft;86;58;59;85;59;67;74;72;68;51 04:08:10 INFO - PROCESS | 1672 | |4;audio-oscillator;91;70;87;72;70;70;89;71;101;119 04:08:10 INFO - PROCESS | 1672 | |5;imaging-gaussian-blur;90;89;90;89;91;88;91;89;91;87 04:08:10 INFO - PROCESS | 1672 | |6;imaging-darkroom;95;100;95;95;95;106;121;150;96;95 04:08:10 INFO - PROCESS | 1672 | |7;imaging-desaturate;113;150;119;99;131;147;92;92;91;92 04:08:10 INFO - PROCESS | 1672 | |8;json-parse-financial;59;56;56;56;58;59;57;57;57;56 04:08:10 INFO - PROCESS | 1672 | |9;json-stringify-tinderbox;74;84;119;78;67;69;70;71;72;70 04:08:10 INFO - PROCESS | 1672 | |10;stanford-crypto-aes;101;87;93;88;86;91;84;90;83;109 04:08:10 INFO - PROCESS | 1672 | |11;stanford-crypto-ccm;152;161;161;163;167;155;164;168;185;148 04:08:10 INFO - PROCESS | 1672 | |12;stanford-crypto-pbkdf2;184;247;173;236;217;176;177;175;173;187 04:08:10 INFO - PROCESS | 1672 | |13;stanford-crypto-sha256-iterative;68;71;79;86;86;69;68;70;67;71 04:08:10 INFO - PROCESS | 1672 | __end_tp_report 04:08:10 INFO - PROCESS | 1672 | __start_cc_report 04:08:10 INFO - PROCESS | 1672 | _x_x_mozilla_cycle_collect,932 04:08:10 INFO - PROCESS | 1672 | __end_cc_report 04:08:10 INFO - PROCESS | 1672 | __startTimestamp1475579290138__endTimestamp 04:08:10 INFO - PROCESS | 1672 | 04:08:10 INFO - PROCESS | 1672 | ------- Summary: start ------- 04:08:10 INFO - PROCESS | 1672 | Number of tests: 14 04:08:10 INFO - PROCESS | 1672 | 04:08:10 INFO - PROCESS | 1672 | [#0] ai-astar Cycles:10 Average:115.80 Median:117.00 stddev:3.85 (3.3%) stddev-sans-first:0.71 04:08:10 INFO - PROCESS | 1672 | Values: 105.0 116.0 116.0 117.0 117.0 118.0 118.0 117.0 117.0 117.0 04:08:10 INFO - PROCESS | 1672 | 04:08:10 INFO - PROCESS | 1672 | [#1] audio-beat-detection Cycles:10 Average:129.70 Median:120.00 stddev:20.11 (16.8%) stddev-sans-first:19.80 04:08:10 INFO - PROCESS | 1672 | Values: 151.0 115.0 118.0 151.0 116.0 118.0 120.0 120.0 171.0 117.0 04:08:10 INFO - PROCESS | 1672 | 04:08:10 INFO - PROCESS | 1672 | [#2] audio-dft Cycles:10 Average:201.30 Median:201.00 stddev:7.06 (3.5%) stddev-sans-first:7.48 04:08:10 INFO - PROCESS | 1672 | Values: 201.0 208.0 218.0 197.0 201.0 197.0 196.0 199.0 202.0 194.0 04:08:10 INFO - PROCESS | 1672 | 04:08:10 INFO - PROCESS | 1672 | [#3] audio-fft Cycles:10 Average:67.90 Median:70.00 stddev:11.63 (16.6%) stddev-sans-first:10.33 04:08:10 INFO - PROCESS | 1672 | Values: 86.0 58.0 59.0 85.0 59.0 67.0 74.0 72.0 68.0 51.0 04:08:10 INFO - PROCESS | 1672 | 04:08:10 INFO - PROCESS | 1672 | [#4] audio-oscillator Cycles:10 Average:84.00 Median:71.50 stddev:16.66 (23.3%) stddev-sans-first:17.48 04:08:10 INFO - PROCESS | 1672 | Values: 91.0 70.0 87.0 72.0 70.0 70.0 89.0 71.0 101.0 119.0 04:08:10 INFO - PROCESS | 1672 | 04:08:10 INFO - PROCESS | 1672 | [#5] imaging-gaussian-blur Cycles:10 Average:89.50 Median:90.00 stddev:1.35 (1.5%) stddev-sans-first:1.42 04:08:10 INFO - PROCESS | 1672 | Values: 90.0 89.0 90.0 89.0 91.0 88.0 91.0 89.0 91.0 87.0 04:08:10 INFO - PROCESS | 1672 | 04:08:10 INFO - PROCESS | 1672 | [#6] imaging-darkroom Cycles:10 Average:104.80 Median:95.00 stddev:17.91 (18.9%) stddev-sans-first:18.64 04:08:10 INFO - PROCESS | 1672 | Values: 95.0 100.0 95.0 95.0 95.0 106.0 121.0 150.0 96.0 95.0 04:08:10 INFO - PROCESS | 1672 | 04:08:10 INFO - PROCESS | 1672 | [#7] imaging-desaturate Cycles:10 Average:112.60 Median:91.50 stddev:23.30 (25.5%) stddev-sans-first:24.71 04:08:10 INFO - PROCESS | 1672 | Values: 113.0 150.0 119.0 99.0 131.0 147.0 92.0 92.0 91.0 92.0 04:08:10 INFO - PROCESS | 1672 | 04:08:10 INFO - PROCESS | 1672 | [#8] json-parse-financial Cycles:10 Average:57.10 Median:57.00 stddev:1.20 (2.1%) stddev-sans-first:1.05 04:08:10 INFO - PROCESS | 1672 | Values: 59.0 56.0 56.0 56.0 58.0 59.0 57.0 57.0 57.0 56.0 04:08:10 INFO - PROCESS | 1672 | 04:08:10 INFO - PROCESS | 1672 | [#9] json-stringify-tinderbox Cycles:10 Average:77.40 Median:71.50 stddev:15.44 (21.6%) stddev-sans-first:16.32 04:08:10 INFO - PROCESS | 1672 | Values: 74.0 84.0 119.0 78.0 67.0 69.0 70.0 71.0 72.0 70.0 04:08:10 INFO - PROCESS | 1672 | 04:08:10 INFO - PROCESS | 1672 | [#10] stanford-crypto-aes Cycles:10 Average:91.20 Median:87.50 stddev:8.11 (9.3%) stddev-sans-first:7.79 04:08:10 INFO - PROCESS | 1672 | Values: 101.0 87.0 93.0 88.0 86.0 91.0 84.0 90.0 83.0 109.0 04:08:10 INFO - PROCESS | 1672 | 04:08:10 INFO - PROCESS | 1672 | [#11] stanford-crypto-ccm Cycles:10 Average:162.40 Median:163.50 stddev:10.22 (6.3%) stddev-sans-first:10.13 04:08:10 INFO - PROCESS | 1672 | Values: 152.0 161.0 161.0 163.0 167.0 155.0 164.0 168.0 185.0 148.0 04:08:10 INFO - PROCESS | 1672 | 04:08:10 INFO - PROCESS | 1672 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:194.50 Median:185.50 stddev:28.10 (15.1%) stddev-sans-first:29.54 04:08:10 INFO - PROCESS | 1672 | Values: 184.0 247.0 173.0 236.0 217.0 176.0 177.0 175.0 173.0 187.0 04:08:10 INFO - PROCESS | 1672 | 04:08:10 INFO - PROCESS | 1672 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.50 Median:71.00 stddev:7.38 (10.4%) stddev-sans-first:7.56 04:08:10 INFO - PROCESS | 1672 | Values: 68.0 71.0 79.0 86.0 86.0 69.0 68.0 70.0 67.0 71.0 04:08:10 INFO - PROCESS | 1672 | -------- Summary: end -------- 04:08:10 INFO - PROCESS | 1672 | 04:08:10 INFO - TEST-INFO | 1672: exit 0 04:08:10 INFO - TEST-OK | kraken | took 60542ms 04:08:10 INFO - SUITE-END | took 1175s 04:08:11 INFO - Completed test suite (00:19:36) 04:08:11 INFO - javascript benchmark 04:08:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7273.755719350281, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2824.632797736295, 2872.339361946752, 3129.6870312968704, 3236.352729454108, 3270.771046026779, 5134.948650513494, 5479.232907392963, 5529.115341545354, 5554.1391084381885, 5555.416681248466, 5422.810201642943, 5464.972675136629, 5494.2857428534235, 5525.972370138154, 5584.52531534819, 4990.27640992056, 5003.199488081917, 5064.822731204408, 5124.0776660201145, 5124.948750512484, 5037.59699224063, 5095.184770436731, 5122.206058061007, 5146.974265128669, 5173.30160428343, 4953.083679519301, 4977.676451030671, 5074.188129899217, 5110.029094472038, 5135.871603209912, 5038.370203724535, 5049.924251136236, 5071.2139618359215, 5072.670276432057, 5097.23541468779, 4983.6760610560195, 4988.925166122511, 5057.645964782467, 5063.620228482879, 5064.797408103672, 5302.575793936476, 5363.115086010804, 5373.408925018245, 5402.324709411324, 5433.592480563973, 5993.0, 5993.130996005599, 6001.819945401645, 6035.78874739382, 6072.119542666289, 6076.392360763933, 6133.570650054498, 6138.355472675394, 6143.938560614426, 6195.938040619581, 5488.588355873326, 5555.444455554412, 5647.729260916302, 5660.462256085706, 5672.177534257509, 6136.140940268366, 6151.83115208109, 6161.84595385119, 6189.473894718909, 6221.96889015552, 5956.55325850563, 5976.223090998143, 5983.338794396016, 6010.519158467312, 6071.878562428727, 6044.879102417927, 6088.0, 6132.141500189977, 6165.784197553064, 6173.166622505994, 5829.125631155361, 5963.5825492216, 5989.700514974234, 6034.63792172471, 6134.4172303631085, 6075.058365953284, 6084.148219249309, 6091.08633704939, 6111.144439778434, 6113.5414843886, 4730.692504987233, 4813.663043586986, 4817.686850354716, 4836.322914791932, 4867.586255168279, 4238.830446782094, 4261.126469073833, 4271.145770845781, 4288.849890253826, 4330.545292744279, 5500.22996780451, 5532.612717109763, 5563.36021357541, 5571.888562228733, 5646.6894320811925, 5269.420363759983, 6035.969820150871, 6073.4837538808815, 6077.270727512727, 6090.147379366892, 4603.49361570227, 5399.6490228135835, 5497.890042199134, 5557.5831812613405, 5574.498295153456, 5235.947640523546, 5262.184361423985, 5263.605229607795, 5281.15501519755, 5284.101702710548, 6164.907526387108, 6169.444749972524, 6189.50483961282, 6211.782587609412, 6221.9377806221355, 4885.364902562644, 5923.7926672566255, 5993.220881285405, 6119.051547010221, 6164.198654174928, 5025.0, 5093.923591146062, 6175.197224360804, 6211.223597050369, 6240.157578726814, 4566.543345665407, 5852.590318677651, 6006.399360064133, 6011.248593925759, 6021.2473440819895, 5758.1362795579325, 5984.790532331347, 5994.970025149846, 6104.664243466652, 6166.414190651881, 5915.497182739343, 5927.585069045125, 5943.0, 5960.791372302122, 6029.57792954489, 5855.414458554111, 5889.5582831286965, 5894.381089985662, 5904.468597826216, 5918.940810591839, 5568.303962004749, 5600.299962504687, 5610.158476228598, 5734.7132643368495, 5749.741261643319, 5845.357010728731, 5882.705864706833, 5896.911546326723, 5913.793017244376, 5915.201447804491, 5727.8568035799435, 5735.655860648374, 5756.16535602327, 5762.913556296743, 5792.623479473821], "value": 5490.116319521999, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [487.6220928780195, 510.5150107397972, 516.8449465160451, 518.8313798015646, 526.7892842862856, 42414.36378454322, 44016.779916100415, 44188.0, 44262.778686106525, 44359.556404435985, 43605.78197109018, 43675.0, 43742.56257437425, 43858.56141438585, 44058.77970610143, 9862.457564833949, 10060.245481588874, 10075.848862267072, 10079.949600251988, 10090.596376144946, 9788.021197880225, 9793.16758075561, 9892.455914924676, 9896.653617123402, 9898.455584942825, 9704.902950970505, 9787.902120978806, 9795.853062204036, 9910.603575856992, 9927.354721943051, 8299.419040667126, 9821.950890245575, 9849.753756156118, 9857.162141218005, 9880.011998800135, 9761.316707830454, 9802.950985245028, 9864.654737084167, 9878.90121098787, 9890.554925028391, 40719.796401017804, 40862.38706419406, 41280.79359603183, 41351.966200844916, 41361.379579306034, 2699.452091407185, 3286.507023946427, 3328.5340052392444, 3679.8712045078296, 4081.346984482498, 31090.378192436252, 31393.744250229964, 31525.054248372584, 31774.682253177405, 32354.19114522132, 3024.0625406124173, 3055.236190952262, 3060.7704422168426, 3129.1707697460192, 3149.5275708643885, 414245.0, 427181.0, 430419.0, 432032.0, 436878.9999999968, 49779.502204977485, 52890.0, 59871.40128598658, 60917.0, 64314.8195367309, 51004.979900401784, 61497.0, 62209.0, 62326.0651090234, 63301.68349158225, 16281.0, 16354.264058117413, 16515.33938642465, 16527.008379497267, 16535.421260255833, 11315.660530184108, 12596.55912043074, 12708.364581770875, 12813.487460501476, 12825.23048617086, 14842.40630374773, 16124.67750645004, 17349.7397539037, 17369.47891563255, 17391.956482611084, 6057.303410107806, 6576.8819300719, 6795.456363490909, 6930.272321406281, 6975.8604827903155, 862.7584276402617, 919.9264058875274, 925.421611492817, 1021.5096753558186, 1052.9420881851418, 29304.85347573291, 30214.395712085636, 30416.695833041827, 30421.39157216843, 30760.271176991926, 966.9758256043655, 1051.6003918510917, 1060.2684147937898, 1117.80997230471, 1203.3381640097912, 14982.250887455584, 15688.843111568738, 15795.025621797275, 15886.52340429789, 16035.839641603434, 598289.0, 600110.0, 600754.0, 602815.0, 608656.0, 57453.0, 57623.71188144032, 58381.41618583845, 58594.0, 58679.0, 1278.520554791953, 1321.0158431968052, 1321.557278311757, 1327.5419980106847, 1334.4462048249868, 29450.852745736134, 30208.24479387945, 30397.088087357413, 30458.61175372628, 30756.692433075383, 35034.0, 42467.787661062735, 50900.745496272284, 51308.74345628248, 51500.227496586835, 382916.0, 552994.0, 560541.0, 561130.0, 561429.0, 40909.590904090575, 41165.44266523981, 41700.79149604232, 41821.53624623123, 41824.79087604542, 46638.76680616575, 47194.52805472039, 47449.76275118603, 48472.757636211594, 48527.75736121297, 38694.6130538691, 38711.7625999444, 39573.0, 39980.400293996194, 40264.396034058926, 34114.14714632154, 36510.63489365072, 38437.03907402337, 39327.41008884926, 39819.80090099531, 38512.6148738509, 38695.6130438692, 39505.80247098746, 39569.406458903715, 40970.0, 31003.844980774953, 33447.83276083604, 34432.45053972527, 35440.0, 35458.822705886305, 24405.755942440348, 24774.38064048413, 26094.73905260923, 26132.8693356532, 26566.203013909613], "value": 20001.88306984281, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [313.7129526483268, 367.3552914634817, 367.9981600092, 379.59383459698137, 397.5825383347486, 19590.314338998138, 20421.28525501604, 20546.794532054675, 20830.583388332223, 21074.262400815973, 19854.106565204565, 20054.0, 20199.0, 20255.797442025574, 20873.895630521863, 5583.190437386576, 5859.560532960024, 5886.264216972879, 6154.076888466721, 6157.815265542018, 3823.025128592219, 5923.08192230205, 5967.04527275636, 5971.014782560872, 5971.701414929258, 3983.0, 5876.764929402819, 6147.139400483936, 6195.81412557624, 6220.502359811204, 5846.766129354842, 5966.97016514919, 6028.939710602882, 6185.041318595625, 6194.597351172182, 5617.0731829248125, 5652.886942261173, 5742.799002034951, 5783.62406443584, 5825.0679891217205, 10391.740206494822, 12874.678133046655, 23048.11898512686, 24977.250682479556, 25491.362715932064, 1979.4358607796853, 2276.578832915916, 2388.773066558674, 2557.9104731334314, 2774.7780177585946, 9678.806423871483, 9777.262945561426, 9854.16239619626, 10177.949110254476, 10251.282410231286, 1420.9076410033417, 1675.0201132337597, 1842.68674325365, 1864.9627007459774, 1895.3271588585992, 103928.44107338396, 110990.0, 112092.0, 116546.0, 119071.4046429771, 11279.92840680134, 11332.660020199408, 11401.543938242377, 11620.825687614693, 11681.532738690357, 14226.14643121416, 14396.064255823338, 14416.207108608918, 14441.422343106367, 14443.06120102211, 8075.878861817077, 8367.330613551023, 8384.0, 8457.619407126695, 8502.0, 8228.753137405887, 8260.793480163044, 8321.209485098905, 8369.49783013021, 8436.367272454469, 4418.690691651618, 4451.376807246988, 4482.955170448254, 4583.610393116623, 4594.609458196024, 1584.7860538827342, 1903.1435853865817, 1933.4489670443857, 1943.9805601944083, 2014.6071516054521, 799.9480033797785, 817.5666896544841, 853.2406158518924, 865.9177378149066, 884.255504342146, 20585.176592936114, 21221.0, 21408.892955535124, 21584.352469425943, 21602.891985539973, 821.8931538900024, 896.3635818568889, 975.6536429567401, 990.3513198854762, 1016.9593216271414, 9914.752131196778, 10022.498875056219, 10386.688399348031, 11443.313401195956, 11528.942355288169, 550966.0, 556500.0, 557153.0, 594960.0, 598277.0, 117667.0, 125561.0, 127074.0938885899, 128086.35956820156, 128575.0, 937.3157594955584, 937.7843096087802, 968.5399435268332, 969.486172328667, 969.6606187834343, 18828.811711882707, 19027.858328500333, 19150.04249787533, 19266.0, 19417.417477475698, 41455.7927210362, 52542.161024363966, 55366.72316638552, 55462.613434664454, 55475.722621388246, 77087.61456192684, 77329.2267077322, 78871.81692274506, 79107.4178516438, 79446.6027669858, 7167.104111986002, 7173.282671732785, 7349.265073492608, 7391.926080739124, 7539.849203016019, 10545.0, 12720.422454596819, 12904.8064279034, 12969.54606588765, 12992.480300787862, 9252.907470925475, 9958.900410995797, 10811.405372704263, 11164.609238676607, 11194.384308863091, 10792.0, 10834.0, 10834.729131771768, 11187.664370068911, 11393.974542291233, 10691.939002132056, 10924.563017479211, 11273.323600583992, 11461.369624670722, 11752.823707644222, 8125.959370203112, 8179.63191656365, 8273.46222495536, 8343.41596088268, 8454.746357609281, 8820.647174112964, 11079.556817727524, 11275.548978041115, 11416.200865939636, 11734.0], "value": 9346.917711949356, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1540.6533529955757, 1561.898476599021, 1694.5848267174536, 1798.1998010885154, 1856.4523465577654, 8017.719379821693, 8268.173182681729, 8656.826863462727, 9281.99999999999, 9296.674616388427, 8701.869471957925, 9003.594838232279, 9107.180353768159, 9143.77140571486, 9144.862827057583, 1970.9356947248468, 2369.6208606622945, 2395.7244916834525, 2400.099962514057, 2405.170216275391, 2035.4911272181955, 2352.235523454884, 2376.4534157143867, 2388.916387926423, 2399.9640005399847, 2250.2011785816044, 2252.583272094668, 2259.2092767531317, 2267.954640907181, 2274.647429648407, 2282.2468585366787, 2347.9765202348012, 2356.2931120663816, 2358.3750306168877, 2362.350353652742, 2293.7591552886875, 2295.185209250709, 2299.482616411311, 2299.6435552489393, 2304.043821813945, 9100.453972761656, 9157.77105572366, 9207.802985611894, 9212.815743685156, 9236.5843537041, 4909.509049095098, 5048.268001139851, 5061.822836200715, 5091.05815424144, 5107.182850743863, 3431.811250381228, 3517.771344862576, 3636.3999940009867, 3657.4696668983115, 3662.176010397666, 1025.2054657640315, 1047.9161667066617, 1062.7130674717782, 1077.1544337694872, 1084.8860869608657, 11592.188546801643, 12102.334371609559, 12151.453184606715, 12253.754924901541, 12271.754564908651, 4607.3319368691355, 4642.535746425398, 4848.660593758474, 4888.437829649564, 4892.217245240744, 10145.695629131138, 10164.0344167304, 10248.795024099476, 10256.076953074109, 10294.970502949795, 5297.443768404339, 5374.704391258519, 5389.218563308376, 5390.54180394663, 5399.920015996817, 4411.691181617321, 4545.704529205591, 4696.7651617419, 4846.273059041101, 4964.404271487372, 3958.6239307265764, 3982.3230050891416, 3997.8600748974227, 4099.262132816122, 4111.198316328288, 1288.1755676367131, 1297.2475963940892, 1304.8303720516271, 1309.463120120746, 1309.7511472820133, 918.4030380252889, 923.35826600512, 938.8122375524922, 953.5934496617434, 972.1833659725722, 5829.562782791223, 6009.0, 6106.9083963739695, 6155.230596175478, 6172.321044685081, 384.41952651496445, 431.39604553625173, 441.0737451352199, 444.6842741653462, 457.4373520569718, 4004.8598299059395, 4030.6170913763144, 4062.370332598452, 4115.176964607031, 4116.279651061112, 10777.299475534066, 11047.944760276308, 11228.606998755167, 11250.987411133037, 11252.831207531894, 11127.944360278309, 11197.888021119847, 11204.215704900578, 11221.326720396639, 11268.71828204285, 8394.412391132684, 8441.198086181803, 8490.49057056591, 8502.14978502145, 8504.192101750325, 5781.219535362672, 5976.9103463448955, 6036.9698151508965, 6070.514358851369, 6114.357992410733, 9754.463504507321, 10291.94854025725, 10327.741806454898, 10336.0, 10431.269811113149, 10268.127209187003, 10461.738456538647, 10474.68575942723, 10489.423081730578, 10495.317804342692, 6403.679816009274, 6591.406773390418, 7162.713491460283, 7493.550386976799, 7502.512336698097, 7988.920110798817, 8543.145685431657, 8546.871796922927, 8553.786155346166, 8565.05784363732, 7198.89201661965, 7337.376323012603, 7345.742898998509, 7349.853002939804, 7481.401487881065, 6575.572587781779, 7281.344678978918, 7424.294692004251, 7529.134149572869, 7533.924660753322, 6229.719662615103, 6264.49884009269, 6971.198312193959, 7095.290470952863, 7097.46768992338, 4328.9134217316105, 5043.823466178666, 5069.112905241642, 5084.008618319393, 5120.590352771695, 4983.875403114806, 5051.823186188466, 5079.111155547838, 5095.031943930641, 5104.872378190575], "value": 4532.684948291345, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [258.5823894410527, 259.7208001398497, 275.3254526410295, 295.3811764353678, 310.39473027596193, 4917.360743103396, 5415.431379705134, 5591.524720398766, 5673.404292549274, 5688.374278829326, 4506.526814684452, 4919.139150648631, 5288.096285337285, 5316.680999140054, 5420.539254163391, 4191.889149375418, 4218.493780746299, 4266.33354153654, 4274.166537525184, 4281.422008028907, 4152.792360381984, 4175.812088456027, 4231.209218517562, 4265.914681706379, 4289.2334444283415, 4169.499660040799, 4187.539370669239, 4206.642435392995, 4216.430781844442, 4219.303814870543, 4233.470816147981, 4238.660907127453, 4242.724222925531, 4257.14857028594, 4270.722403043807, 3534.8688419705704, 3649.7627654202392, 3659.396199627058, 3669.7798132112157, 3712.7215458840697, 4466.280482014447, 4713.858584242478, 5428.728563571845, 5454.809081682161, 5473.0969390050595, 4045.271851066807, 4846.079244943449, 4852.636052296092, 4855.660103792736, 4857.222844344888, 5585.273914391103, 5637.802676906289, 5780.786034932669, 5814.418558144194, 5891.705414729289, 3367.9831600842085, 3955.307821131319, 3966.5636779954184, 3971.590085519628, 3987.521497420328, 4924.753762311906, 5485.506304432581, 5640.266765320482, 5690.06113991191, 6099.390060993909, 3540.831525596547, 3596.5324507813816, 3704.388775852008, 3914.825552334288, 4025.355943049098, 3151.5115157150676, 3158.368326334742, 3201.6158061032825, 3756.3050835594954, 3967.6230758077936, 4050.736702114353, 4155.8753237402925, 4387.692861499728, 4687.062587482517, 4940.258961155783, 5900.8399078649445, 5922.822315330547, 5954.523638108941, 5975.4007006952115, 5981.7607295707685, 1319.4392383237277, 1371.2184055088703, 1372.2315503318173, 1395.0304538345956, 1403.8207905359548, 773.1765669561898, 938.7467730579616, 958.3866325551653, 964.7781010367514, 966.2270183852889, 4622.491525932145, 5516.558675305966, 5538.587660146637, 5546.64588298184, 5634.140733557998, 6001.0, 6006.939930600638, 6016.998695867287, 6071.574989750675, 6085.726142323606, 4927.90144197114, 5169.663971841894, 5482.205080263339, 5486.478784515464, 5624.0439125348785, 2359.6314137800036, 2638.5118753030365, 2670.1588999465107, 2676.9024699872957, 2734.293049880604, 4330.783460826946, 4464.955350446519, 4728.243481043017, 4940.2342636891335, 5139.563137133386, 4330.653547716175, 4351.369051487517, 4778.761061946958, 5062.595267248102, 5305.0, 6139.899350827893, 6303.873922521616, 6319.368063193736, 6367.331430199855, 6367.968160159169, 5376.516113549799, 5431.8098866539485, 5680.829575112753, 6160.784372546939, 6162.907556386747, 5344.514800617731, 6008.218931538872, 6041.516678665784, 6041.758329666764, 6100.0849872519475, 5103.387593488656, 5960.642361458326, 6016.608920420159, 6364.236291644847, 6430.035494675836, 3753.024213704402, 3960.4257382679925, 3981.5421226559315, 4005.9399109012807, 4015.9799201003807, 5296.258523806593, 5764.538836893123, 6029.969850150721, 6039.698015099315, 6116.3883611638485, 5246.475352464723, 5804.303483581997, 5977.535503801597, 5998.700064996646, 6001.129836173817, 5371.40914499397, 5945.791897283574, 5952.642841429528, 5991.7603295867675, 6004.39956004396, 5262.0, 5623.493885550321, 5815.244018277597, 5827.854303642443, 5891.967271291398, 4924.482929292516, 5673.943260567342, 5806.838632273647, 5888.3228428729535, 5904.232449781501, 4399.362092496634, 4692.906141877212, 4958.776855041459, 5397.460253974571, 5531.751071201725], "value": 4157.76541722607, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [734.79425760787, 747.2415498269256, 750.9924900750991, 789.6249281591241, 819.8931442552553, 14878.851211487896, 14923.701525969474, 15969.680606387865, 15990.200489975497, 16010.839891601081, 14335.139891606512, 14572.417103315882, 14638.634034149152, 14646.0, 14658.560243192722, 669.7689297192461, 688.9207741109786, 849.155090684768, 876.8158686675806, 878.0473186592554, 843.9324854011695, 860.1312674199041, 872.8428882801094, 873.5108339329964, 875.9737207883742, 874.0778478704964, 876.3733930239878, 893.4817805672727, 923.007766650853, 926.2913870888775, 898.3935843305743, 908.8818453601056, 913.7121806630923, 913.980911283917, 917.5779141594875, 658.4633523678187, 680.45223595006, 681.9352161544646, 682.0621645237798, 682.5154140560159, 14033.929830350886, 14355.210463424508, 14372.64068398288, 14559.272036398244, 14577.70844583113, 14373.568792936125, 14419.78370324446, 14453.927730361385, 14704.632384190374, 14790.260486975716, 11934.641960741192, 11970.82043769344, 11980.58067967617, 12030.759384812254, 12035.628076192963, 3763.435484677293, 3826.2921359548295, 3828.942565861514, 3880.9029774255587, 3945.2898478274187, 114831.0, 118667.406662967, 118735.2189717155, 119689.0, 120100.0, 11172.273802202993, 11226.438678066064, 11264.774704505864, 11278.436078196057, 11409.885901140882, 19009.524761880788, 19338.03309834531, 19785.901070494554, 22646.320610381714, 22858.542829143324, 6698.866022679519, 7270.418366530771, 7489.887651685229, 8116.715914942949, 8206.302464290602, 3896.7661940283674, 4185.518665353462, 4198.202341555095, 4273.743575385487, 4384.517703052662, 3428.280061187129, 3557.0573797943566, 3558.2705545363137, 3558.288342331544, 3576.445650924111, 645.3546453546453, 646.8221239159175, 666.2171947961126, 667.2093569120608, 673.4275865514371, 536.841631718644, 589.4400319696306, 604.3503234023442, 634.1388026143193, 644.7711062572719, 8926.821463570823, 9010.831040721712, 9030.593623286968, 9057.77355566116, 9112.134347237003, 536.4045909040962, 588.608575297431, 624.6002558362652, 625.2528228766671, 625.7403177681211, 4207.179599978036, 4362.124286556747, 4391.626711729475, 4445.644348452116, 4461.930522644971, 167280.0, 169118.30881691273, 170970.0, 172474.0, 174747.0, 117052.0, 117378.41310793562, 119325.80674193321, 130249.0, 142632.0, 30798.230044248627, 31896.0, 32033.0, 33969.49045764316, 110474.0, 9650.758731031781, 9747.561359738687, 9977.800443991226, 10036.799264014533, 10303.278770485995, 47836.760816195696, 53347.19979200393, 58263.70868145632, 65943.67028164829, 66480.33519664935, 92851.0, 95401.0, 96230.51884740531, 96696.0, 98511.0, 12784.360781960679, 12906.80639790385, 13045.608631741063, 13123.60629181126, 13135.146215495963, 14401.567952961428, 14668.55994320172, 14814.62963425923, 15185.316660750514, 15322.387104515694, 13359.666008349868, 13511.391987360788, 13645.0, 13667.111637743516, 13891.235982021086, 13354.131981421177, 13742.312884355943, 13810.10234334765, 14136.78794818099, 14221.075630084011, 13459.932700336436, 13553.661158471117, 13642.795358069437, 13763.449462021406, 13783.173009619455, 11015.669529914116, 11119.555217791198, 11131.610393636183, 11512.654620361403, 11691.532338706356, 10345.482725863827, 10495.609465694239, 10992.418162513279, 11659.18385712992, 11697.824532632187], "value": 7655.435112282382, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1561.7000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 116.0, 116.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0], "value": 115.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 115.0, 118.0, 151.0, 116.0, 118.0, 120.0, 120.0, 171.0, 117.0], "value": 129.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [201.0, 208.0, 218.0, 197.0, 201.0, 197.0, 196.0, 199.0, 202.0, 194.0], "value": 201.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 58.0, 59.0, 85.0, 59.0, 67.0, 74.0, 72.0, 68.0, 51.0], "value": 67.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 70.0, 87.0, 72.0, 70.0, 70.0, 89.0, 71.0, 101.0, 119.0], "value": 84.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 89.0, 90.0, 89.0, 91.0, 88.0, 91.0, 89.0, 91.0, 87.0], "value": 89.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 100.0, 95.0, 95.0, 95.0, 106.0, 121.0, 150.0, 96.0, 95.0], "value": 104.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 150.0, 119.0, 99.0, 131.0, 147.0, 92.0, 92.0, 91.0, 92.0], "value": 112.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 56.0, 56.0, 56.0, 58.0, 59.0, 57.0, 57.0, 57.0, 56.0], "value": 57.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 84.0, 119.0, 78.0, 67.0, 69.0, 70.0, 71.0, 72.0, 70.0], "value": 77.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 87.0, 93.0, 88.0, 86.0, 91.0, 84.0, 90.0, 83.0, 109.0], "value": 91.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 161.0, 161.0, 163.0, 167.0, 155.0, 164.0, 168.0, 185.0, 148.0], "value": 162.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 247.0, 173.0, 236.0, 217.0, 176.0, 177.0, 175.0, 173.0, 187.0], "value": 194.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 71.0, 79.0, 86.0, 86.0, 69.0, 68.0, 70.0, 67.0, 71.0], "value": 73.5, "unit": "score"}]}]} 04:08:11 INFO - Return code: 0 04:08:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:08:11 ERROR - # TBPL SUCCESS # 04:08:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:08:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:08:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:08:11 INFO - 2016-10-04 04:08:11.478 screenresolution[1677:10513] starting screenresolution argv=screenresolution get 04:08:11 INFO - 2016-10-04 04:08:11.481 screenresolution[1677:10513] Display 0: 1600x1200x32@60 04:08:11 INFO - 2016-10-04 04:08:11.487 screenresolution[1678:10516] starting screenresolution argv=screenresolution list 04:08:11 INFO - Available Modes on Display 0 04:08:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:08:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:08:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:08:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:08:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:08:11 INFO - Intel Iris: 04:08:11 INFO - Chipset Model: Intel Iris 04:08:11 INFO - Type: GPU 04:08:11 INFO - Bus: Built-In 04:08:11 INFO - VRAM (Dynamic, Max): 1536 MB 04:08:11 INFO - Vendor: Intel (0x8086) 04:08:11 INFO - Device ID: 0x0a2e 04:08:11 INFO - Revision ID: 0x0009 04:08:11 INFO - Displays: 04:08:11 INFO - Display: 04:08:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:08:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:08:11 INFO - Display Serial Number: 1600x1200 60 04:08:11 INFO - Main Display: Yes 04:08:11 INFO - Mirror: Off 04:08:11 INFO - Online: Yes 04:08:11 INFO - Rotation: Supported 04:08:11 INFO - Return code: 0 04:08:11 INFO - Running post-action listener: _resource_record_post_action 04:08:11 INFO - [mozharness: 2016-10-04 11:08:11.722200Z] Finished run-tests step (success) 04:08:11 INFO - Running post-run listener: _resource_record_post_run 04:08:11 INFO - Total resource usage - Wall time: 1211s; CPU: 55.0%; Read bytes: 37587456; Write bytes: 710637568; Read time: 246; Write time: 1953 04:08:11 INFO - TinderboxPrint: CPU usage
54.5% 04:08:11 INFO - TinderboxPrint: I/O read bytes / time
37,587,456 / 246 04:08:11 INFO - TinderboxPrint: I/O write bytes / time
710,637,568 / 1,953 04:08:11 INFO - TinderboxPrint: CPU idle
2,202.6 (45.5%) 04:08:11 INFO - TinderboxPrint: CPU system
980.5 (20.2%) 04:08:11 INFO - TinderboxPrint: CPU user
1,662.5 (34.3%) 04:08:11 INFO - TinderboxPrint: Swap in / out
444,981,248 / 0 04:08:11 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 387224064; Write bytes: 382224384; Read time: 29357; Write time: 767 04:08:11 INFO - run-tests - Wall time: 1177s; CPU: 55.0%; Read bytes: 36633088; Write bytes: 299913216; Read time: 234; Write time: 1121 04:08:12 INFO - Running post-run listener: _upload_blobber_files 04:08:12 INFO - Blob upload gear active. 04:08:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:08:12 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:08:12 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:08:12 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:08:12 INFO - (blobuploader) - INFO - Open directory for files ... 04:08:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:08:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:08:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:08:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:08:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:08:13 INFO - (blobuploader) - INFO - Done attempting. 04:08:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:08:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:08:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:08:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:08:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:08:14 INFO - (blobuploader) - INFO - Done attempting. 04:08:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:08:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:08:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:08:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:08:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:08:16 INFO - (blobuploader) - INFO - Done attempting. 04:08:16 INFO - (blobuploader) - INFO - Iteration through files over. 04:08:16 INFO - Return code: 0 04:08:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:08:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:08:16 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/be4e80c990f92f28341d9d45a57fcf482f788ed47e3c63e35b0425c8ca543969d36a976db826724c342bc9bd36790f43a88b7cf3f99ebcb87611d5607e51f233", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/876cdf39703345b4fd2c08f9e423a90d46eaba9c0465d2bd417d72b6004e743a634ec4e27093af41d4f41c1199a21c35f908c6016c34822f66f8ffc1d3b20490", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fdff29f20dc1a55756d693040bb3ce45f39797865e45602dc78d7ef8b97ae88d9e9d179ac297bd96b2c6b16f0fc0b31faf0c32fc27d2639acacf5ee943474f11"} 04:08:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:08:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:08:16 INFO - Contents: 04:08:16 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/be4e80c990f92f28341d9d45a57fcf482f788ed47e3c63e35b0425c8ca543969d36a976db826724c342bc9bd36790f43a88b7cf3f99ebcb87611d5607e51f233", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/876cdf39703345b4fd2c08f9e423a90d46eaba9c0465d2bd417d72b6004e743a634ec4e27093af41d4f41c1199a21c35f908c6016c34822f66f8ffc1d3b20490", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fdff29f20dc1a55756d693040bb3ce45f39797865e45602dc78d7ef8b97ae88d9e9d179ac297bd96b2c6b16f0fc0b31faf0c32fc27d2639acacf5ee943474f11"} 04:08:16 INFO - Running post-run listener: copy_logs_to_upload_dir 04:08:16 INFO - Copying logs to upload dir... 04:08:16 INFO - mkdir: /builds/slave/test/build/upload/logs 04:08:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.306533 ========= master_lag: 0.23 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-10-04 04:08:16.927120) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 04:08:16.934185) ========= 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.1Lbz7SntsU/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.FJI4NFwUdF/Listeners TMPDIR=/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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/Fx-Team/sha512/be4e80c990f92f28341d9d45a57fcf482f788ed47e3c63e35b0425c8ca543969d36a976db826724c342bc9bd36790f43a88b7cf3f99ebcb87611d5607e51f233", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/876cdf39703345b4fd2c08f9e423a90d46eaba9c0465d2bd417d72b6004e743a634ec4e27093af41d4f41c1199a21c35f908c6016c34822f66f8ffc1d3b20490", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fdff29f20dc1a55756d693040bb3ce45f39797865e45602dc78d7ef8b97ae88d9e9d179ac297bd96b2c6b16f0fc0b31faf0c32fc27d2639acacf5ee943474f11"} build_url:https://queue.taskcluster.net/v1/task/Eb-HMLHIRC6RXE5ppQbLyw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011363 build_url: 'https://queue.taskcluster.net/v1/task/Eb-HMLHIRC6RXE5ppQbLyw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/be4e80c990f92f28341d9d45a57fcf482f788ed47e3c63e35b0425c8ca543969d36a976db826724c342bc9bd36790f43a88b7cf3f99ebcb87611d5607e51f233", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/876cdf39703345b4fd2c08f9e423a90d46eaba9c0465d2bd417d72b6004e743a634ec4e27093af41d4f41c1199a21c35f908c6016c34822f66f8ffc1d3b20490", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fdff29f20dc1a55756d693040bb3ce45f39797865e45602dc78d7ef8b97ae88d9e9d179ac297bd96b2c6b16f0fc0b31faf0c32fc27d2639acacf5ee943474f11"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 04:08:16.977379) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 04:08:16.977700) ========= 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.1Lbz7SntsU/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.FJI4NFwUdF/Listeners TMPDIR=/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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.005152 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 04:08:17.028559) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 04:08:17.028884) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 04:08:17.029196) ========= ========= Total master_lag: 0.38 =========