builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0083 starttime: 1492794961.45 results: success (0) buildid: 20170421075727 builduid: 663796e3f41d4184aaf2cc5d2956b74c revision: 303f73e7411bf3c5b9b27c1a4505d8afcb9f3f85 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-21 10:16:01.445874) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-21 10:16:01.446298) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-21 10:16:01.446573) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-21 10:16:01.474040) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 10:16:01.474419) ========= 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.ZF1eju7fy4/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.FVwaqIVpfh/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-04-21 10:16:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 20.3M=0.001s 2017-04-21 10:16:01 (20.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.173218 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 10:16:01.670869) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 10:16:01.671237) ========= 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.ZF1eju7fy4/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.FVwaqIVpfh/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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.027397 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 10:16:01.721601) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-21 10:16:01.721979) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 303f73e7411bf3c5b9b27c1a4505d8afcb9f3f85 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 303f73e7411bf3c5b9b27c1a4505d8afcb9f3f85 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ZF1eju7fy4/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.FVwaqIVpfh/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-04-21 10:16:01,787 truncating revision to first 12 chars 2017-04-21 10:16:01,787 Setting DEBUG logging. 2017-04-21 10:16:01,788 attempt 1/10 2017-04-21 10:16:01,788 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/303f73e7411b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-21 10:16:03,651 unpacking tar archive at: mozilla-central-303f73e7411b/testing/mozharness/ program finished with exit code 0 elapsedTime=2.145412 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-21 10:16:03.891996) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-21 10:16:03.892318) ========= script_repo_revision: 303f73e7411bf3c5b9b27c1a4505d8afcb9f3f85 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-21 10:16:03.892744) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-21 10:16:03.893034) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-21 10:16:03.913525) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-04-21 10:16:03.913938) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ZF1eju7fy4/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.FVwaqIVpfh/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 10:16:04 INFO - MultiFileLogger online at 20170421 10:16:04 in /builds/slave/test 10:16:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:16:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:16:04 INFO - {'append_to_log': False, 10:16:04 INFO - 'base_work_dir': '/builds/slave/test', 10:16:04 INFO - 'blob_upload_branch': 'Firefox', 10:16:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:16:04 INFO - 'branch': 'Firefox', 10:16:04 INFO - 'buildbot_json_path': 'buildprops.json', 10:16:04 INFO - 'config_files': ('talos/mac_config.py',), 10:16:04 INFO - 'default_actions': ('clobber', 10:16:04 INFO - 'read-buildbot-config', 10:16:04 INFO - 'download-and-extract', 10:16:04 INFO - 'populate-webroot', 10:16:04 INFO - 'create-virtualenv', 10:16:04 INFO - 'install', 10:16:04 INFO - 'run-tests'), 10:16:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:16:04 INFO - 'download_minidump_stackwalk': True, 10:16:04 INFO - 'download_symbols': 'ondemand', 10:16:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:16:04 INFO - 'tooltool.py': '/tools/tooltool.py', 10:16:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:16:04 INFO - '/tools/misc-python/virtualenv.py')}, 10:16:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:16:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:16:04 INFO - 'gecko_profile': False, 10:16:04 INFO - 'gecko_profile_interval': 0, 10:16:04 INFO - 'installer_path': 'installer.exe', 10:16:04 INFO - 'log_level': 'info', 10:16:04 INFO - 'log_name': 'talos', 10:16:04 INFO - 'log_to_console': True, 10:16:04 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:16:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:16:04 INFO - 'opt_config_files': (), 10:16:04 INFO - 'pip_index': False, 10:16:04 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:16:04 INFO - 'cmd': ('bash', 10:16:04 INFO - '-c', 10:16:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:16:04 INFO - 'enabled': True, 10:16:04 INFO - 'halt_on_failure': False, 10:16:04 INFO - 'name': 'check_screen_resolution'},), 10:16:04 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:16:04 INFO - 'cmd': ('bash', 10:16:04 INFO - '-c', 10:16:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:16:04 INFO - 'enabled': True, 10:16:04 INFO - 'halt_on_failure': False, 10:16:04 INFO - 'name': 'check_screen_resolution'},), 10:16:04 INFO - 'run_cmd_checks_enabled': True, 10:16:04 INFO - 'suite': 'dromaeojs-e10s', 10:16:04 INFO - 'system_bits': '32', 10:16:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:16:04 INFO - 'title': 't-yosemite-r7-0083', 10:16:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:16:04 INFO - 'use_talos_json': True, 10:16:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:16:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:16:04 INFO - 'work_dir': 'build'} 10:16:04 INFO - [mozharness: 2017-04-21 17:16:04.088233Z] Running clobber step. 10:16:04 INFO - Running pre-action listener: _resource_record_pre_action 10:16:04 INFO - Running main action method: clobber 10:16:04 INFO - rmtree: /builds/slave/test/build 10:16:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:16:06 INFO - Running post-action listener: _resource_record_post_action 10:16:06 INFO - [mozharness: 2017-04-21 17:16:06.687020Z] Finished clobber step (success) 10:16:06 INFO - [mozharness: 2017-04-21 17:16:06.687284Z] Running read-buildbot-config step. 10:16:06 INFO - Running pre-action listener: _resource_record_pre_action 10:16:06 INFO - Running main action method: read_buildbot_config 10:16:06 INFO - Using buildbot properties: 10:16:06 INFO - { 10:16:06 INFO - "project": "", 10:16:06 INFO - "product": "firefox", 10:16:06 INFO - "script_repo_revision": "production", 10:16:06 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 10:16:06 INFO - "repository": "", 10:16:06 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 10:16:06 INFO - "buildid": "20170421075727", 10:16:06 INFO - "pgo_build": "False", 10:16:06 INFO - "basedir": "/builds/slave/test", 10:16:06 INFO - "buildnumber": 36, 10:16:06 INFO - "slavename": "t-yosemite-r7-0083", 10:16:06 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 10:16:06 INFO - "platform": "yosemite_r7", 10:16:06 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 10:16:06 INFO - "branch": "mozilla-central", 10:16:06 INFO - "repo_path": "mozilla-central", 10:16:06 INFO - "revision": "303f73e7411bf3c5b9b27c1a4505d8afcb9f3f85", 10:16:06 INFO - "stage_platform": "macosx64", 10:16:06 INFO - "builduid": "663796e3f41d4184aaf2cc5d2956b74c", 10:16:06 INFO - "slavebuilddir": "test" 10:16:06 INFO - } 10:16:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/A8mF30RvQR6XfNnStBRG4g/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 10:16:06 INFO - Running post-action listener: _resource_record_post_action 10:16:06 INFO - [mozharness: 2017-04-21 17:16:06.693075Z] Finished read-buildbot-config step (success) 10:16:06 INFO - [mozharness: 2017-04-21 17:16:06.693289Z] Running download-and-extract step. 10:16:06 INFO - Running pre-action listener: _resource_record_pre_action 10:16:06 INFO - Running main action method: download_and_extract 10:16:06 INFO - mkdir: /builds/slave/test/build/tests 10:16:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:06 INFO - trying https://queue.taskcluster.net/v1/task/A8mF30RvQR6XfNnStBRG4g/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 10:16:06 INFO - Downloading https://queue.taskcluster.net/v1/task/A8mF30RvQR6XfNnStBRG4g/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 10:16:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A8mF30RvQR6XfNnStBRG4g/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 10:16:08 INFO - Downloaded 1325 bytes. 10:16:08 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 10:16:08 INFO - Using the following test package requirements: 10:16:08 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:16:08 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 10:16:08 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 10:16:08 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:16:08 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 10:16:08 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:16:08 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 10:16:08 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:16:08 INFO - u'jsshell-mac.zip'], 10:16:08 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:16:08 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 10:16:08 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 10:16:08 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:16:08 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 10:16:08 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:16:08 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 10:16:08 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:16:08 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 10:16:08 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:16:08 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 10:16:08 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:16:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A8mF30RvQR6XfNnStBRG4g/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 10:16:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A8mF30RvQR6XfNnStBRG4g/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:16:08 INFO - Fetch https://queue.taskcluster.net/v1/task/A8mF30RvQR6XfNnStBRG4g/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 10:16:09 INFO - Expected file size: 52526553 10:16:09 INFO - Obtained file size: 52526553 10:16:26 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 10:16:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A8mF30RvQR6XfNnStBRG4g/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 10:16:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A8mF30RvQR6XfNnStBRG4g/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:16:26 INFO - Fetch https://queue.taskcluster.net/v1/task/A8mF30RvQR6XfNnStBRG4g/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 10:16:28 INFO - Expected file size: 52526553 10:16:28 INFO - Obtained file size: 52526553 10:16:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A8mF30RvQR6XfNnStBRG4g/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 10:16:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A8mF30RvQR6XfNnStBRG4g/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 10:16:43 INFO - Fetch https://queue.taskcluster.net/v1/task/A8mF30RvQR6XfNnStBRG4g/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 10:16:44 INFO - Expected file size: 14408811 10:16:44 INFO - Obtained file size: 14408811 10:16:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:45 INFO - trying https://queue.taskcluster.net/v1/task/A8mF30RvQR6XfNnStBRG4g/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 10:16:45 INFO - Downloading https://queue.taskcluster.net/v1/task/A8mF30RvQR6XfNnStBRG4g/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 10:16:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A8mF30RvQR6XfNnStBRG4g/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 10:16:47 INFO - Downloaded 71029896 bytes. 10:16:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/A8mF30RvQR6XfNnStBRG4g/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 10:16:47 INFO - mkdir: /builds/slave/test/properties 10:16:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:16:47 INFO - Writing to file /builds/slave/test/properties/build_url 10:16:47 INFO - Contents: 10:16:47 INFO - build_url:https://queue.taskcluster.net/v1/task/A8mF30RvQR6XfNnStBRG4g/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 10:16:47 INFO - Running post-action listener: _resource_record_post_action 10:16:47 INFO - Running post-action listener: set_extra_try_arguments 10:16:47 INFO - [mozharness: 2017-04-21 17:16:47.799873Z] Finished download-and-extract step (success) 10:16:47 INFO - [mozharness: 2017-04-21 17:16:47.800035Z] Running populate-webroot step. 10:16:47 INFO - Running pre-action listener: _resource_record_pre_action 10:16:47 INFO - Running main action method: populate_webroot 10:16:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:16:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:16:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:16:47 INFO - '--tppagecycles', 10:16:47 INFO - '7'], 10:16:47 INFO - 'tests': ['tsvgm']}}, 10:16:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:16:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:16:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:16:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:16:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:16:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:16:47 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:16:47 INFO - 'talos_options': ['--disable-e10s'], 10:16:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:16:47 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:16:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:16:47 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:16:47 INFO - 'talos_options': ['--disable-e10s'], 10:16:47 INFO - 'tests': ['damp', 'tps']}, 10:16:47 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:16:47 INFO - 'tests': ['damp', 'tps']}, 10:16:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:16:47 INFO - 'tests': ['dromaeo_dom']}, 10:16:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:16:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:16:47 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 10:16:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 10:16:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:16:47 INFO - 'tests': ['a11yr', 10:16:47 INFO - 'ts_paint', 10:16:47 INFO - 'tpaint', 10:16:47 INFO - 'sessionrestore', 10:16:47 INFO - 'sessionrestore_no_auto_restore', 10:16:47 INFO - 'tabpaint']}, 10:16:47 INFO - 'other-e10s': {'tests': ['a11yr', 10:16:47 INFO - 'ts_paint', 10:16:47 INFO - 'tpaint', 10:16:47 INFO - 'sessionrestore', 10:16:47 INFO - 'sessionrestore_no_auto_restore', 10:16:47 INFO - 'tabpaint']}, 10:16:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:16:47 INFO - 'ts_paint', 10:16:47 INFO - 'tpaint', 10:16:47 INFO - 'sessionrestore', 10:16:47 INFO - 'sessionrestore_no_auto_restore', 10:16:47 INFO - 'tabpaint']}, 10:16:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:16:47 INFO - 'ts_paint', 10:16:47 INFO - 'tpaint', 10:16:47 INFO - 'sessionrestore', 10:16:47 INFO - 'sessionrestore_no_auto_restore', 10:16:47 INFO - 'tabpaint']}, 10:16:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:16:47 INFO - 'tests': ['a11yr', 10:16:47 INFO - 'ts_paint', 10:16:47 INFO - 'tpaint', 10:16:47 INFO - 'sessionrestore', 10:16:47 INFO - 'sessionrestore_no_auto_restore', 10:16:47 INFO - 'tabpaint']}, 10:16:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:16:47 INFO - 'tests': ['a11yr', 10:16:47 INFO - 'ts_paint', 10:16:47 INFO - 'tpaint', 10:16:47 INFO - 'sessionrestore', 10:16:47 INFO - 'sessionrestore_no_auto_restore', 10:16:47 INFO - 'tabpaint']}, 10:16:47 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 10:16:47 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 10:16:47 INFO - 'bloom_basic_ref']}, 10:16:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:16:47 INFO - 'tests': ['tsvgx', 10:16:47 INFO - 'tsvgr_opacity', 10:16:47 INFO - 'tart', 10:16:47 INFO - 'tscrollx', 10:16:47 INFO - 'cart', 10:16:47 INFO - 'tsvg_static']}, 10:16:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:16:47 INFO - 'tsvgr_opacity', 10:16:47 INFO - 'tart', 10:16:47 INFO - 'tscrollx', 10:16:47 INFO - 'cart', 10:16:47 INFO - 'tsvg_static']}, 10:16:47 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:16:47 INFO - 'talos_options': ['--disable-e10s'], 10:16:47 INFO - 'tests': ['tp5o']}, 10:16:47 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:16:47 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:16:47 INFO - 'talos_options': ['--disable-e10s', 10:16:47 INFO - '--xperf_path', 10:16:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:16:47 INFO - 'tests': ['tp5n']}, 10:16:47 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:16:47 INFO - 'talos_options': ['--xperf_path', 10:16:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:16:47 INFO - 'tests': ['tp5n']}}, 10:16:47 INFO - 'talos.zip': {'path': '', 10:16:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:16:47 INFO - Running post-action listener: _resource_record_post_action 10:16:47 INFO - [mozharness: 2017-04-21 17:16:47.818673Z] Finished populate-webroot step (success) 10:16:47 INFO - [mozharness: 2017-04-21 17:16:47.818800Z] Running create-virtualenv step. 10:16:47 INFO - Running pre-action listener: _resource_record_pre_action 10:16:47 INFO - Running main action method: create_virtualenv 10:16:47 INFO - Creating virtualenv /builds/slave/test/build/venv 10:16:47 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:16:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:16:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:16:47 INFO - Using real prefix '/tools/python27' 10:16:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:16:48 INFO - Installing distribute.............................................................................................................................................................................................done. 10:16:51 INFO - Installing pip.................done. 10:16:51 INFO - Return code: 0 10:16:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:16:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:16:51 INFO - Reading from file tmpfile_stdout 10:16:51 INFO - Output received: 10:16:51 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 10:16:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:16:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:51 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 0x1008f5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008f8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab39c9dd60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006d3d30>, '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 0x1005f9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006c8be8>, '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.ZF1eju7fy4/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.FVwaqIVpfh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:16:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:16:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:16:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZF1eju7fy4/Render', 10:16:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:16:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:16:51 INFO - 'HOME': '/Users/cltbld', 10:16:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:16:51 INFO - 'LOGNAME': 'cltbld', 10:16:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:51 INFO - 'MOZ_NO_REMOTE': '1', 10:16:51 INFO - 'NO_EM_RESTART': '1', 10:16:51 INFO - 'PAGER': '/bin/cat', 10:16:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:16:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:51 INFO - 'PWD': '/builds/slave/test', 10:16:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:16:51 INFO - 'SHELL': '/bin/bash', 10:16:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FVwaqIVpfh/Listeners', 10:16:51 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 10:16:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:16:51 INFO - 'USER': 'cltbld', 10:16:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:16:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:16:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:51 INFO - 'XPC_FLAGS': '0x0', 10:16:51 INFO - 'XPC_SERVICE_NAME': '0', 10:16:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:16:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:52 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:16:52 INFO - Cleaning up... 10:16:52 INFO - Return code: 0 10:16:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:16: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')]} 10:16:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16: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')]} 10:16:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1008f5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008f8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab39c9dd60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006d3d30>, '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 0x1005f9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006c8be8>, '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.ZF1eju7fy4/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.FVwaqIVpfh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:16:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:16:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:16:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZF1eju7fy4/Render', 10:16:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:16:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:16:52 INFO - 'HOME': '/Users/cltbld', 10:16:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:16:52 INFO - 'LOGNAME': 'cltbld', 10:16:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:52 INFO - 'MOZ_NO_REMOTE': '1', 10:16:52 INFO - 'NO_EM_RESTART': '1', 10:16:52 INFO - 'PAGER': '/bin/cat', 10:16:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:16:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:52 INFO - 'PWD': '/builds/slave/test', 10:16:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:16:52 INFO - 'SHELL': '/bin/bash', 10:16:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FVwaqIVpfh/Listeners', 10:16:52 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 10:16:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:16:52 INFO - 'USER': 'cltbld', 10:16:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:16:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:16:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:52 INFO - 'XPC_FLAGS': '0x0', 10:16:52 INFO - 'XPC_SERVICE_NAME': '0', 10:16:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:16:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:52 INFO - Downloading/unpacking psutil>=3.1.1 10:16:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:16:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:16:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:16:55 INFO - Installing collected packages: psutil 10:16:55 INFO - Running setup.py install for psutil 10:16:55 INFO - building 'psutil._psutil_osx' extension 10:16:55 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 10:16:56 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 10:16:56 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 10:16:56 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 10:16:56 INFO - building 'psutil._psutil_posix' extension 10:16:56 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 10:16:56 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:16:56 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:16:56 INFO - ^ 10:16:56 INFO - 1 warning generated. 10:16:56 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 10:16:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:16:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:16:57 INFO - Successfully installed psutil 10:16:57 INFO - Cleaning up... 10:16:57 INFO - Return code: 0 10:16:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:16: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')]} 10:16:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16: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')]} 10:16:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:57 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 0x1008f5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008f8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab39c9dd60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006d3d30>, '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 0x1005f9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006c8be8>, '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.ZF1eju7fy4/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.FVwaqIVpfh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:16:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:16:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:16:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZF1eju7fy4/Render', 10:16:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:16:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:16:57 INFO - 'HOME': '/Users/cltbld', 10:16:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:16:57 INFO - 'LOGNAME': 'cltbld', 10:16:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:57 INFO - 'MOZ_NO_REMOTE': '1', 10:16:57 INFO - 'NO_EM_RESTART': '1', 10:16:57 INFO - 'PAGER': '/bin/cat', 10:16:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:16:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:57 INFO - 'PWD': '/builds/slave/test', 10:16:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:16:57 INFO - 'SHELL': '/bin/bash', 10:16:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FVwaqIVpfh/Listeners', 10:16:57 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 10:16:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:16:57 INFO - 'USER': 'cltbld', 10:16:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:16:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:16:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:57 INFO - 'XPC_FLAGS': '0x0', 10:16:57 INFO - 'XPC_SERVICE_NAME': '0', 10:16:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:16:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:16:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:17:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:17:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:17:01 INFO - Installing collected packages: mozsystemmonitor 10:17:01 INFO - Running setup.py install for mozsystemmonitor 10:17:01 INFO - Successfully installed mozsystemmonitor 10:17:01 INFO - Cleaning up... 10:17:01 INFO - Return code: 0 10:17:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:17:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:17:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:17:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1008f5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008f8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab39c9dd60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006d3d30>, '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 0x1005f9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006c8be8>, '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.ZF1eju7fy4/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.FVwaqIVpfh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:17:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:17:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:17:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZF1eju7fy4/Render', 10:17:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:17:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:17:01 INFO - 'HOME': '/Users/cltbld', 10:17:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:17:01 INFO - 'LOGNAME': 'cltbld', 10:17:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:01 INFO - 'MOZ_NO_REMOTE': '1', 10:17:01 INFO - 'NO_EM_RESTART': '1', 10:17:01 INFO - 'PAGER': '/bin/cat', 10:17:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:17:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:01 INFO - 'PWD': '/builds/slave/test', 10:17:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:17:01 INFO - 'SHELL': '/bin/bash', 10:17:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FVwaqIVpfh/Listeners', 10:17:01 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 10:17:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:17:01 INFO - 'USER': 'cltbld', 10:17:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:17:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:17:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:01 INFO - 'XPC_FLAGS': '0x0', 10:17:01 INFO - 'XPC_SERVICE_NAME': '0', 10:17:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:17:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:02 INFO - Downloading/unpacking jsonschema==2.5.1 10:17:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:17:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:05 INFO - Downloading functools32-3.2.3-2.tar.gz 10:17:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:17:05 INFO - warning: no files found matching '*.txt' 10:17:05 INFO - no previously-included directories found matching 'build' 10:17:05 INFO - no previously-included directories found matching 'dist' 10:17:05 INFO - no previously-included directories found matching '.git*' 10:17:05 INFO - Installing collected packages: jsonschema, functools32 10:17:05 INFO - Running setup.py install for functools32 10:17:05 INFO - warning: no files found matching '*.txt' 10:17:05 INFO - no previously-included directories found matching 'build' 10:17:05 INFO - no previously-included directories found matching 'dist' 10:17:05 INFO - no previously-included directories found matching '.git*' 10:17:05 INFO - Successfully installed jsonschema functools32 10:17:05 INFO - Cleaning up... 10:17:05 INFO - Return code: 0 10:17:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:17: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')]} 10:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17: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')]} 10:17:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:05 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 0x1008f5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008f8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab39c9dd60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006d3d30>, '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 0x1005f9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006c8be8>, '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.ZF1eju7fy4/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.FVwaqIVpfh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:17:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:17:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:17:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZF1eju7fy4/Render', 10:17:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:17:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:17:05 INFO - 'HOME': '/Users/cltbld', 10:17:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:17:05 INFO - 'LOGNAME': 'cltbld', 10:17:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:05 INFO - 'MOZ_NO_REMOTE': '1', 10:17:05 INFO - 'NO_EM_RESTART': '1', 10:17:05 INFO - 'PAGER': '/bin/cat', 10:17:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:17:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:05 INFO - 'PWD': '/builds/slave/test', 10:17:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:17:05 INFO - 'SHELL': '/bin/bash', 10:17:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FVwaqIVpfh/Listeners', 10:17:05 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 10:17:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:17:05 INFO - 'USER': 'cltbld', 10:17:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:17:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:17:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:05 INFO - 'XPC_FLAGS': '0x0', 10:17:05 INFO - 'XPC_SERVICE_NAME': '0', 10:17:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:17:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:17:05 INFO - Cleaning up... 10:17:05 INFO - Return code: 0 10:17:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:17: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')]} 10:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17: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')]} 10:17:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:05 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 0x1008f5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008f8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab39c9dd60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006d3d30>, '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 0x1005f9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006c8be8>, '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.ZF1eju7fy4/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.FVwaqIVpfh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:17:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:17:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:17:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZF1eju7fy4/Render', 10:17:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:17:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:17:05 INFO - 'HOME': '/Users/cltbld', 10:17:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:17:05 INFO - 'LOGNAME': 'cltbld', 10:17:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:05 INFO - 'MOZ_NO_REMOTE': '1', 10:17:05 INFO - 'NO_EM_RESTART': '1', 10:17:05 INFO - 'PAGER': '/bin/cat', 10:17:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:17:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:05 INFO - 'PWD': '/builds/slave/test', 10:17:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:17:05 INFO - 'SHELL': '/bin/bash', 10:17:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FVwaqIVpfh/Listeners', 10:17:05 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 10:17:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:17:05 INFO - 'USER': 'cltbld', 10:17:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:17:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:17:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:05 INFO - 'XPC_FLAGS': '0x0', 10:17:05 INFO - 'XPC_SERVICE_NAME': '0', 10:17:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:17:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:05 INFO - Downloading/unpacking blobuploader==1.2.4 10:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:08 INFO - Downloading blobuploader-1.2.4.tar.gz 10:17:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:17:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:17:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:17:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:17:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:09 INFO - Downloading docopt-0.6.1.tar.gz 10:17:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:17:09 INFO - Installing collected packages: blobuploader, requests, docopt 10:17:09 INFO - Running setup.py install for blobuploader 10:17:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:17:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:17:10 INFO - Running setup.py install for requests 10:17:10 INFO - Running setup.py install for docopt 10:17:10 INFO - Successfully installed blobuploader requests docopt 10:17:10 INFO - Cleaning up... 10:17:10 INFO - Return code: 0 10:17:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:17:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:17:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:17:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:10 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 0x1008f5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008f8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab39c9dd60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006d3d30>, '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 0x1005f9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006c8be8>, '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.ZF1eju7fy4/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.FVwaqIVpfh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:17:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:17:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:17:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZF1eju7fy4/Render', 10:17:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:17:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:17:10 INFO - 'HOME': '/Users/cltbld', 10:17:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:17:10 INFO - 'LOGNAME': 'cltbld', 10:17:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:10 INFO - 'MOZ_NO_REMOTE': '1', 10:17:10 INFO - 'NO_EM_RESTART': '1', 10:17:10 INFO - 'PAGER': '/bin/cat', 10:17:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:17:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:10 INFO - 'PWD': '/builds/slave/test', 10:17:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:17:10 INFO - 'SHELL': '/bin/bash', 10:17:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FVwaqIVpfh/Listeners', 10:17:10 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 10:17:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:17:10 INFO - 'USER': 'cltbld', 10:17:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:17:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:17:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:10 INFO - 'XPC_FLAGS': '0x0', 10:17:10 INFO - 'XPC_SERVICE_NAME': '0', 10:17:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:17:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:17:11 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-mJWr6z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:17:11 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-3eahyX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:17:11 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-eYEgcV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:17:11 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-hns7UW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:17:11 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-cSx1WI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:17:11 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-6fp15B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:17:11 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-0hYwCH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:17:11 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-fDZVkz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:17:11 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-1IQjsV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:17:11 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-RD5QLd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:17:12 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-AZPYrx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:17:12 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-CR6DrC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:17:12 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-lPsmmm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:17:12 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-K2sffX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:17:12 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-JB4pfW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:17:12 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-EsFkWs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:17:12 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-X3XuLd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:17:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:17:12 INFO - Running setup.py install for manifestparser 10:17:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:17:12 INFO - Running setup.py install for mozcrash 10:17:13 INFO - Running setup.py install for mozdebug 10:17:13 INFO - Running setup.py install for mozdevice 10:17:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:17:13 INFO - Running setup.py install for mozfile 10:17:13 INFO - Running setup.py install for mozhttpd 10:17:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:17:13 INFO - Running setup.py install for mozinfo 10:17:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:17:13 INFO - Running setup.py install for mozInstall 10:17:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:17:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:17:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:17:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:17:13 INFO - Running setup.py install for mozleak 10:17:14 INFO - Running setup.py install for mozlog 10:17:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:17:14 INFO - Running setup.py install for moznetwork 10:17:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:17:14 INFO - Running setup.py install for mozprocess 10:17:14 INFO - Running setup.py install for mozprofile 10:17:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:17:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:17:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:17:14 INFO - Running setup.py install for mozrunner 10:17:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:17:14 INFO - Running setup.py install for mozscreenshot 10:17:15 INFO - Running setup.py install for moztest 10:17:15 INFO - Running setup.py install for mozversion 10:17:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:17:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:17:15 INFO - Cleaning up... 10:17:15 INFO - Return code: 0 10:17:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:17:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:17:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:17:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:15 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 0x1008f5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008f8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab39c9dd60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006d3d30>, '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 0x1005f9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006c8be8>, '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.ZF1eju7fy4/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.FVwaqIVpfh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:17:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:17:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:17:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZF1eju7fy4/Render', 10:17:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:17:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:17:15 INFO - 'HOME': '/Users/cltbld', 10:17:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:17:15 INFO - 'LOGNAME': 'cltbld', 10:17:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:15 INFO - 'MOZ_NO_REMOTE': '1', 10:17:15 INFO - 'NO_EM_RESTART': '1', 10:17:15 INFO - 'PAGER': '/bin/cat', 10:17:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:17:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:15 INFO - 'PWD': '/builds/slave/test', 10:17:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:17:15 INFO - 'SHELL': '/bin/bash', 10:17:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FVwaqIVpfh/Listeners', 10:17:15 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 10:17:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:17:15 INFO - 'USER': 'cltbld', 10:17:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:17:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:17:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:15 INFO - 'XPC_FLAGS': '0x0', 10:17:15 INFO - 'XPC_SERVICE_NAME': '0', 10:17:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:17:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:17:15 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-gwzVVp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:17:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:17:15 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-aDvPdz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:17:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:17:15 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-sQPprt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:17:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:17:15 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-ZT6cNY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:17:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:17:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:17:16 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-k2gRte-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:17:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:17:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:17:16 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-JYpgmZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:17:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:17:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:17:16 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-b_n9H9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:17:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:17:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:17:16 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-VtebWK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:17:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:17:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:17:16 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-yMH_Zg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:17:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:17:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:17:16 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-Y5Y0qY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:17:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:17:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:17:16 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-J4AO0p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:17:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:17:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:17:16 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-QJX_UF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:17:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:17:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:17:16 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-71Dk_w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:17:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:17:17 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-E1OAxh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:17:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:17:17 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-8V94I6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:17:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:17:17 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-bcL07T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:17:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:17:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:17:17 INFO - Running setup.py (path:/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/pip-OWase0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:17:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:17:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:17:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:17:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:17:17 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:17:17 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:17:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:17:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:19 INFO - Downloading blessings-1.6.tar.gz 10:17:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:17:20 INFO - Installing collected packages: blessings 10:17:20 INFO - Running setup.py install for blessings 10:17:20 INFO - Successfully installed blessings 10:17:20 INFO - Cleaning up... 10:17:20 INFO - Return code: 0 10:17:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:17:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:17:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:17:20 INFO - Reading from file tmpfile_stdout 10:17:20 INFO - Current package versions: 10:17:20 INFO - blessings == 1.6 10:17:20 INFO - blobuploader == 1.2.4 10:17:20 INFO - docopt == 0.6.1 10:17:20 INFO - functools32 == 3.2.3-2 10:17:20 INFO - jsonschema == 2.5.1 10:17:20 INFO - manifestparser == 1.1 10:17:20 INFO - mozInstall == 1.12 10:17:20 INFO - mozcrash == 1.0 10:17:20 INFO - mozdebug == 0.1 10:17:20 INFO - mozdevice == 0.50 10:17:20 INFO - mozfile == 1.2 10:17:20 INFO - mozhttpd == 0.7 10:17:20 INFO - mozinfo == 0.9 10:17:20 INFO - mozleak == 0.1 10:17:20 INFO - mozlog == 3.4 10:17:20 INFO - moznetwork == 0.27 10:17:20 INFO - mozprocess == 0.25 10:17:20 INFO - mozprofile == 0.28 10:17:20 INFO - mozrunner == 6.13 10:17:20 INFO - mozscreenshot == 0.1 10:17:20 INFO - mozsystemmonitor == 0.3 10:17:20 INFO - moztest == 0.8 10:17:20 INFO - mozversion == 1.4 10:17:20 INFO - psutil == 3.1.1 10:17:20 INFO - requests == 1.2.3 10:17:20 INFO - wsgiref == 0.1.2 10:17:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:17:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:17:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:17:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:20 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 0x1008f5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008f8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab39c9dd60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006d3d30>, '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 0x1005f9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006c8be8>, '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.ZF1eju7fy4/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.FVwaqIVpfh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:17:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:17:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:17:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZF1eju7fy4/Render', 10:17:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:17:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:17:20 INFO - 'HOME': '/Users/cltbld', 10:17:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:17:20 INFO - 'LOGNAME': 'cltbld', 10:17:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:20 INFO - 'MOZ_NO_REMOTE': '1', 10:17:20 INFO - 'NO_EM_RESTART': '1', 10:17:20 INFO - 'PAGER': '/bin/cat', 10:17:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:17:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:20 INFO - 'PWD': '/builds/slave/test', 10:17:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:17:20 INFO - 'SHELL': '/bin/bash', 10:17:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FVwaqIVpfh/Listeners', 10:17:20 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 10:17:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:17:20 INFO - 'USER': 'cltbld', 10:17:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:17:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:17:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:20 INFO - 'XPC_FLAGS': '0x0', 10:17:20 INFO - 'XPC_SERVICE_NAME': '0', 10:17:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:17:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:17:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:17:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:17:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:17:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:17:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:17:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:17:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:17:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:17:20 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:17:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:17:20 INFO - Cleaning up... 10:17:20 INFO - Return code: 0 10:17:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:17:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:17:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:17:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:20 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 0x1008f5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008f8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab39c9dd60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006d3d30>, '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 0x1005f9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006c8be8>, '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.ZF1eju7fy4/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.FVwaqIVpfh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:17:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:17:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:17:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZF1eju7fy4/Render', 10:17:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:17:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:17:20 INFO - 'HOME': '/Users/cltbld', 10:17:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:17:20 INFO - 'LOGNAME': 'cltbld', 10:17:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:20 INFO - 'MOZ_NO_REMOTE': '1', 10:17:20 INFO - 'NO_EM_RESTART': '1', 10:17:20 INFO - 'PAGER': '/bin/cat', 10:17:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:17:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:20 INFO - 'PWD': '/builds/slave/test', 10:17:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:17:20 INFO - 'SHELL': '/bin/bash', 10:17:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FVwaqIVpfh/Listeners', 10:17:20 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 10:17:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:17:20 INFO - 'USER': 'cltbld', 10:17:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:17:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:17:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:20 INFO - 'XPC_FLAGS': '0x0', 10:17:20 INFO - 'XPC_SERVICE_NAME': '0', 10:17:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:17:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:17:21 INFO - Cleaning up... 10:17:21 INFO - Return code: 0 10:17:21 INFO - Running post-action listener: _resource_record_post_action 10:17:21 INFO - Running post-action listener: _start_resource_monitoring 10:17:21 INFO - Starting resource monitoring. 10:17:21 INFO - [mozharness: 2017-04-21 17:17:21.200413Z] Finished create-virtualenv step (success) 10:17:21 INFO - [mozharness: 2017-04-21 17:17:21.201452Z] Running install step. 10:17:21 INFO - Running pre-action listener: _resource_record_pre_action 10:17:21 INFO - Running main action method: install 10:17:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:17:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:17:21 INFO - Reading from file tmpfile_stdout 10:17:21 INFO - Detecting whether we're running mozinstall >=1.0... 10:17:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:17:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:17:21 INFO - Reading from file tmpfile_stdout 10:17:21 INFO - Output received: 10:17:21 INFO - Usage: mozinstall [options] installer 10:17:21 INFO - Options: 10:17:21 INFO - -h, --help show this help message and exit 10:17:21 INFO - -d DEST, --destination=DEST 10:17:21 INFO - Directory to install application into. [default: 10:17:21 INFO - "/builds/slave/test"] 10:17:21 INFO - --app=APP Application being installed. [default: firefox] 10:17:21 INFO - mkdir: /builds/slave/test/build/application 10:17:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:17:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 10:17:41 INFO - Reading from file tmpfile_stdout 10:17:41 INFO - Output received: 10:17:41 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:17:41 INFO - Running post-action listener: _resource_record_post_action 10:17:41 INFO - [mozharness: 2017-04-21 17:17:41.460811Z] Finished install step (success) 10:17:41 INFO - [mozharness: 2017-04-21 17:17:41.460969Z] Running run-tests step. 10:17:41 INFO - Running pre-action listener: _resource_record_pre_action 10:17:41 INFO - Running main action method: run_tests 10:17:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:17:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:17:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:17:41 INFO - 2017-04-21 10:17:41.475 screenresolution[1618:7413] starting screenresolution argv=screenresolution get 10:17:41 INFO - 2017-04-21 10:17:41.478 screenresolution[1618:7413] Display 0: 1600x1200x32@60 10:17:41 INFO - 2017-04-21 10:17:41.484 screenresolution[1619:7416] starting screenresolution argv=screenresolution list 10:17:41 INFO - Available Modes on Display 0 10:17:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:17:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:17:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:17:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:17:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:17:41 INFO - Intel Iris: 10:17:41 INFO - Chipset Model: Intel Iris 10:17:41 INFO - Type: GPU 10:17:41 INFO - Bus: Built-In 10:17:41 INFO - VRAM (Dynamic, Max): 1536 MB 10:17:41 INFO - Vendor: Intel (0x8086) 10:17:41 INFO - Device ID: 0x0a2e 10:17:41 INFO - Revision ID: 0x0009 10:17:41 INFO - Displays: 10:17:41 INFO - Display: 10:17:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:17:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:17:41 INFO - Display Serial Number: 1600x1200 60 10:17:41 INFO - Main Display: Yes 10:17:41 INFO - Mirror: Off 10:17:41 INFO - Online: Yes 10:17:41 INFO - Rotation: Supported 10:17:41 INFO - Return code: 0 10:17:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:17:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:17:41 INFO - Python 2.7.3 10:17:41 INFO - Return code: 0 10:17:41 INFO - grabbing minidump binary from tooltool 10:17:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:17:41 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 0x1006d3d30>, '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 0x1005f9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006c8be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:17:41 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:17:41 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 10:17:41 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 10:17:41 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:17:41 INFO - Return code: 0 10:17:41 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:17:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:17:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:17:41 INFO - ENV: RUST_BACKTRACE is now 1 10:17:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:17:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:17:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/A8mF30RvQR6XfNnStBRG4g/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0083', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 10:17:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/A8mF30RvQR6XfNnStBRG4g/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0083 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 10:17:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZF1eju7fy4/Render', 10:17:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:17:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:17:41 INFO - 'HOME': '/Users/cltbld', 10:17:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:17:41 INFO - 'LOGNAME': 'cltbld', 10:17:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:17:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:17:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:41 INFO - 'MOZ_NO_REMOTE': '1', 10:17:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:17:41 INFO - 'NO_EM_RESTART': '1', 10:17:41 INFO - 'PAGER': '/bin/cat', 10:17:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:17:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:41 INFO - 'PWD': '/builds/slave/test', 10:17:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:17:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:17:41 INFO - 'RUST_BACKTRACE': '1', 10:17:41 INFO - 'SHELL': '/bin/bash', 10:17:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FVwaqIVpfh/Listeners', 10:17:41 INFO - 'TMPDIR': '/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/', 10:17:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:17:41 INFO - 'USER': 'cltbld', 10:17:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:17:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:17:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:41 INFO - 'XPC_FLAGS': '0x0', 10:17:41 INFO - 'XPC_SERVICE_NAME': '0', 10:17:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:17:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/A8mF30RvQR6XfNnStBRG4g/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0083', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 10:17:42 INFO - mozversion application_buildid: 20170421075727 10:17:42 INFO - mozversion application_changeset: 303f73e7411bf3c5b9b27c1a4505d8afcb9f3f85 10:17:42 INFO - mozversion application_display_name: Nightly 10:17:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:17:42 INFO - mozversion application_name: Firefox 10:17:42 INFO - mozversion application_remotingname: firefox 10:17:42 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:17:42 INFO - mozversion application_vendor: Mozilla 10:17:42 INFO - mozversion application_version: 55.0a1 10:17:42 INFO - mozversion platform_buildid: 20170421075727 10:17:42 INFO - mozversion platform_changeset: 303f73e7411bf3c5b9b27c1a4505d8afcb9f3f85 10:17:42 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:17:42 INFO - mozversion platform_version: 55.0a1 10:17:42 INFO - using testdate: 1492795062 10:17:42 INFO - actual date: 1492795062 10:17:42 INFO - starting webserver on 'localhost:49243' 10:17:42 INFO - SUITE-START | Running 2 tests 10:17:42 INFO - TEST-START | dromaeo_css 10:17:42 INFO - operating with platform_type : mac_ 10:17:42 INFO - Initialising browser for dromaeo_css test... 10:17:42 INFO - TEST-INFO | started process 1629 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/tmpnMMVtA/profile http://localhost:49243/getInfo.html) 10:17:45 INFO - PID 1629 | 2017-04-21 10:17:45.160 plugin-container[1631:7594] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x963f, name = 'com.apple.tsm.portname' 10:17:45 INFO - PID 1629 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:17:45 INFO - PID 1629 | 2017-04-21 10:17:45.163 plugin-container[1631:7594] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4b1b, name = 'com.apple.CFPasteboardClient' 10:17:45 INFO - PID 1629 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:17:45 INFO - PID 1629 | 2017-04-21 10:17:45.163 plugin-container[1631:7594] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:17:45 INFO - PID 1629 | __metrics Screen width/height:1600/1200 10:17:45 INFO - PID 1629 | colorDepth:24 10:17:45 INFO - PID 1629 | Browser inner width/height: 1024/689 10:17:45 INFO - PID 1629 | __metrics 10:17:45 ERROR - PID 1629 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3403: TypeError: this.tabs is undefined 10:17:46 INFO - TEST-INFO | 1629: exit 0 10:17:46 INFO - Browser initialized. 10:17:46 INFO - Running cycle 1/1 for dromaeo_css test... 10:17:46 INFO - TEST-INFO | started process 1632 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/tmpnMMVtA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:17:48 INFO - PID 1632 | 2017-04-21 10:17:48.907 plugin-container[1633:7729] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x964b, name = 'com.apple.tsm.portname' 10:17:48 INFO - PID 1632 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:17:48 INFO - PID 1632 | 2017-04-21 10:17:48.908 plugin-container[1633:7729] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x933f, name = 'com.apple.CFPasteboardClient' 10:17:48 INFO - PID 1632 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:17:48 INFO - PID 1632 | 2017-04-21 10:17:48.908 plugin-container[1633:7729] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:17:58 INFO - PID 1632 | RSS: Main: 236003328 10:17:58 INFO - PID 1632 | 10:21:02 INFO - PID 1632 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 10:21:04 INFO - PID 1632 | RSS: Main: 252989440 10:21:04 INFO - PID 1632 | 10:22:46 INFO - PID 1632 | ************************* 10:22:46 INFO - PID 1632 | A coding exception was thrown and uncaught in a Task. 10:22:46 INFO - PID 1632 | 10:22:46 ERROR - PID 1632 | Full message: TypeError: NetworkError when attempting to fetch resource. 10:22:46 INFO - PID 1632 | Full stack: 10:22:46 INFO - PID 1632 | ************************* 10:22:46 INFO - PID 1632 | ************************* 10:22:46 INFO - PID 1632 | A coding exception was thrown and uncaught in a Task. 10:22:46 INFO - PID 1632 | 10:22:46 ERROR - PID 1632 | Full message: TypeError: NetworkError when attempting to fetch resource. 10:22:46 INFO - PID 1632 | Full stack: 10:22:46 INFO - PID 1632 | ************************* 10:22:46 INFO - PID 1632 | ************************* 10:22:46 INFO - PID 1632 | A coding exception was thrown and uncaught in a Task. 10:22:46 INFO - PID 1632 | 10:22:46 ERROR - PID 1632 | Full message: TypeError: NetworkError when attempting to fetch resource. 10:22:46 INFO - PID 1632 | Full stack: 10:22:46 INFO - PID 1632 | ************************* 10:22:46 INFO - PID 1632 | ************************* 10:22:46 INFO - PID 1632 | A coding exception was thrown and uncaught in a Task. 10:22:46 INFO - PID 1632 | 10:22:46 ERROR - PID 1632 | Full message: TypeError: NetworkError when attempting to fetch resource. 10:22:46 INFO - PID 1632 | Full stack: 10:22:46 INFO - PID 1632 | ************************* 10:24:05 INFO - PID 1632 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 10:24:06 INFO - PID 1632 | RSS: Main: 258363392 10:24:06 INFO - PID 1632 | 10:27:08 INFO - PID 1632 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 10:27:09 INFO - PID 1632 | RSS: Main: 267165696 10:27:09 INFO - PID 1632 | 10:30:10 INFO - PID 1632 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 10:30:11 INFO - PID 1632 | RSS: Main: 260345856 10:30:11 INFO - PID 1632 | 10:33:14 INFO - PID 1632 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 10:33:14 INFO - PID 1632 | RSS: Main: 268951552 10:33:14 INFO - PID 1632 | 10:36:16 INFO - PID 1632 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 10:36:16 INFO - PID 1632 | RSS: Main: 265170944 10:36:16 INFO - PID 1632 | 10:36:16 INFO - PID 1632 | __start_tp_report 10:36:16 INFO - PID 1632 | _x_x_mozilla_page_load 10:36:16 INFO - PID 1632 | _x_x_mozilla_page_load_details 10:36:16 INFO - PID 1632 | |i|pagename|runs| 10:36:16 INFO - PID 1632 | |0;dojo.html;3337.6161741399733;3587.1032241939515;3608.1520842602;3612.6929211017064;3660.469231961365;6057.121717350981;6222.875542489153;6247.593906396087;6257.4994000479965;6295.118683384329;6126.4871384639955;6158.983767678328;6181;6185.072239164117;6312.495000399968;5394.7842086316505;5500.5874559408;5533.833984980457;5596.552275817925;5607.327120745516;4851.902961940777;5448.210009548613;5483.7806487740445;5543.695096769676;5589.972050139743;5510.862228444281;5524.944750552483;5530.5852061095575;5556.249906262663;5597.608167428281;5331.786728530854;5394.379646340682;5403.567714582824;5446.754896029688;5514.862128446781;5395.919061214085;5405.135178371481;5425.050616142199;5438.945610543883;5459.918101228445;4947.257911313296;5537.750801213915;6198.81403557894;6232.813015609494;6241.438270555626;6464.385883341075;6598.208215014229;6616.966915165442;6703.463722902205;6717.63053032083;6796.388325050769;6818.2159051709195;6836.589804611739;6840.965795170992;6857.657117144123;6323.52573556985;6341.936580634227;6342.112104305401;6344.777932772331;6356.71394787231;6578.375054369827;6775.4918381121615;6833.863322733518;6902.965485172542;6978.441724662015;6343.238811342669;6543.280239173687;6593.208814942238;6635.9336406636285;6641.435477984425;5608.298962629671;6648.900266496006;6652.334766523309;6776.593404395752;6813.7955861324235;6582.967085164543;6614.206295244505;6691.832704182434;6721.462283017347;6733.764318248838;6395.968020159869;6510.21877374718;6533.24867640218;6677.699503522354;6717.596944183365;5316.6544174628525;5355.518003379714;5360.276362690986;5371.973140134352;5408.378036525771;4713.575778179912;4740.407449068866;4744.217204161344;4746.1931471649905;4780.11567859947;6194.659293738888;6219.906701399483;6299.653519056405;6349.746010159542;6361.840953976095;6704.128463299739;6764.120664313607;6784.98225266214;6800.65996700163;6811.897821532681;6313.652749098844;6328.272248691459;6363.936360636334;6382.712777925005;6400.7119679614525;5766.394528574523;5988.790392336247;5992.370801065913;6005.429484198994;6016.2479690038745;6829.078074459983;7000.859982800213;7013.263607321158;7048.894266586108;7085.82285442868;6060.545459090497;6400.583962042452;6819.897701534382;6830.45356371499;6831.419329356861;5337.599680023936;6074.785042991508;6075.2405949256345;6762.797116086525;6967.686454109476;5553.527950124285;6426.003969384753;6530.183727034121;6592.67036648156;6648.434883034803;6808.5914845109455;6820.35206655367;6825.795226143224;6832.385085342343;6837.760678376233;4735.550122738335;6102.420270074336;6580.80257592273;6603.966980165261;6613.27254002069;5432.2123292123215;6516.315786842313;6521.934780652323;6577.2436169841085;6595.109660196004;6324.778632747832;6377.585456945284;6447.935520644921;6455.289918109098;6459.4832413405875;6359.332270111571;6565.704543295658;6611.206655201407;6615.702293396905;6639.236487803964;6206.565540412308;6343.0485427186295;6402.647854368054;6416.165898433173;6443.6455994920725 10:36:16 INFO - PID 1632 | |1;ext.html;722.8409749855033;801.9077806052303;819.0499021135482;1160.6344001639477;1253.2981530343009;36275.27449451009;36896.44655330169;37280.627193728054;37348.066298342485;37440;37549;37805.432918506245;37836.62163378365;37845;38023.61976380235;7454.030975973143;7808.141104478503;7945;8012.238837310446;8543.530105844176;8398.412111152222;8466.534340611295;8482.830343393129;8520.40357174998;8528.78678033048;8450.830983380329;8499;8499.660013599449;8510.276626486757;8514.446560973547;7215.530990485601;8481.703140390087;8483.872741908875;8514.70198543048;8523.275521580643;8356.958215208946;8406.663733450654;8415.158484151598;8422.957885210595;8436.282915952152;36710.816445917866;36839.63160368389;36853.63146368555;37037.25925481475;37064.444033339525;3512.4906888501278;3525.629808870083;3555.520004799345;3556.822158892045;3566.732495062881;30271.848640756874;30557.694423055706;30623.2344191397;30756.077317680505;30858;3088.3977624363256;3123.3597112591865;3130.843457827122;3133.6239651242;3147.244661281276;302048;302630;305150;309383.99999999773;309825;47293;47791.522084779404;47873.76063119732;47881.8029549264;47968.04063918702;44846.77576612162;50134.247986280236;50233.748831256344;54630.63423414446;55286.89426211534;14260;14398.784018239734;14403.711925761427;14411.711765764627;14413.927930360282;9316.720498385059;11251.774964500828;11503.907128822748;11526.538938442536;11565.710857228636;14116.153030818185;14127.505537306144;14139.08095973779;14145.504907328193;14202.715945681235;5247.947520524822;6008.399160084044;6153.630782153085;6171.981623032239;6205.503559715212;912.9360944733937;973.5862258540092;1005.607812952949;1032.3702541449709;1050.56926660069;21152.682709759367;23798.04807807703;23900.880495597412;24130.396740081287;24345.835041444854;1097.3964319624174;1100.7138144082596;1102.6030628973563;1139.168407062832;1152.1646806065535;11613.419329033515;12267.38663066843;12311.69220769488;12360.25838449696;12432.813507797391;306888.17341919115;308640.91359086573;309388;311847;324661;56060;56736.14895776567;56752.14871776927;56755.43244567502;56756.71621641865;1431.291510702209;1465.6922046370382;1468.1484738851655;1473.8526147385176;1496.0500082447725;28609.570856437585;29517.11448656544;29850;30087.548686769278;30243.69756302409;37419.251614967005;37573;37686.434703478924;37722.43416348812;37811;283858;285809;286619;287746;288196;34409.82795086008;34503.447344870045;35814.28371432609;36392.81803590965;36456.27087458183;44641.55358446374;45205.77397112994;45437.091258175315;45526.86182845455;45599.31601026054;22503.662445063008;29237.415251694423;29496.115116546538;30650;31526.842365788023;30165.849170754005;30358;30533.389332213676;30982.915597954867;31203.68796312008;36980;37092;37176.44235336526;37242;37260.81369593135;22825;23189.956451959366;28746.85626571854;29206;31121.688783112786;22821.20125795589;24631.753682463663;24642.753572464047;24728.629070563595;24784.876075619508 10:36:16 INFO - PID 1632 | |2;jquery.html;429.6262251840899;434.8586709319471;439.457270271215;449.5976101389257;453.25439651772854;19338.12978415973;20965.895170524145;21679.80761058141;21834.908254587288;21908.671369929445;21424;22378.55242895141;22644;22727.886360568173;22984.425389365275;5914.970425147879;6175.691215439232;6180.6291622502795;6183.103449999748;6195.721192546323;5889.734961926702;6174.9073763893575;6213.161223234873;6214.254289485268;6218.347073557279;5264.8157314494;5908.350081491054;6108.541859360544;6187.412195841388;6192.349803270659;6054.576179667403;6083.756649734005;6126.356732543108;6160.969195153995;6167.599106058115;5280.287161233223;5436.945630543683;5459.918101228484;5459.972700136514;5486.561075113981;26267.474650507073;26781.196564102913;27079;27720.584191236947;28192;2232.7767223277706;2306.850054746436;2309.56118337517;2313.90744370225;2317.826163037762;15259.923700381427;17220.397286094925;17322.133893305283;17738.467845964642;17948.820511794846;2040.1737296394983;2143.9816087358536;2175.2277941330917;2175.684525743774;2182.6071307164702;152965.23517382453;166008.16995915063;168367;168905;169598.1520092404;12579;12641.178323408949;12911.741765164645;12971.286579238043;13055.086143969831;16791.748123778154;16828.915855420888;16829.158542072848;16851.325946961984;16963.66072678564;7354.227806080285;9049.77375565603;9076.500792456347;9085.091490850995;9251.011032628017;7250.383717383976;8552.700655477029;8575.656973720981;8613.69852055175;8769.824603507894;7868.803279918048;7963.6814527418255;8017.759467215993;8038.075621303508;8041.356691464669;2270.8296877734238;2276.430892276931;2277.8633282003134;2299.2872209615075;2480.3923038855596;854.256796586961;937.8077494113691;945.4043952310001;954.4559601027348;965.4159233663532;20101.698474522895;20716.171353145706;21328.893355533124;21593.02831372592;21787;988.3723835364596;1000.7448100734412;1016.5273147986074;1035.3529044347283;1035.6219979707353;10438.425886576311;11089.722756931142;11111.72023343767;11168.162387820947;13078.019148563895;453893;551620;557203;557250;560453;136102;137352.31323843315;139014;141422;142645.28677356755;1183.7336599265097;1212.0667086343467;1239.429862263351;1244.3031902134833;1245.2839617220134;15998.520044398687;17150.7994440388;21435.67846482273;21657.350279491642;22015.449613759145;39230.607693923834;56517;56743.716281419984;57155.42844571667;57525;51056.46830595088;73613.52772944618;75475;81516.59241703754;82050;8344.87482687748;8430.873536896828;8984.595693193953;9134.22359099484;9136.49749263797;10682.359058456517;12737.745245095231;13937;14072.014958952775;14233.786493202817;11581;11701.180917335705;11814.232074915102;11845.644630661094;11946.761064778482;10878.238523303293;10894.67315980522;11103.944480277547;11295.604653837076;11339.262947908359;11461.541538338373;11986.64040078799;12013.399330033288;12359.134860559674;12413.937930310653;8970.102989700978;9080.90919090827;9095.454272743656;9160.358774885693;9184.265258779415;10079.496025198565;10161.288709790244;11882.227655202385;12003.319535265244;12159.452824622736 10:36:16 INFO - PID 1632 | |3;mootools.html;1158.6292386436342;1446.9059511131782;1452.8038714773515;1471.3599584180881;1479.6153000219942;10578.471076446185;11222.831657525123;11566.306021638697;11862.822057669131;12307.876921230785;11689.532418703264;11726.77191333646;11879.940600297008;11888.881111188886;11909.285442873412;2518.3326418499114;2533.3413312538687;2546.3506805764505;2550.1457011901034;2552.055739376424;2477.479729256849;2520.243926821955;2555.7955363570964;2559.308986573624;2563.38478765096;2487;2523.1925783749207;2551.094361501668;2552.0812507497285;2555.642210090589;2369.5024044950583;2449.2774631483753;2522.72250052495;2537.517871604408;2546.9939373947186;2463.728989811137;2520.790020790013;2525.9621105683245;2534.936626584332;2563.0644814642706;11770.882291177064;11848.822267665992;11937.880621193764;11941.761164776743;11951.402429878472;6702.095217145672;6970.616616086113;6972.058772065757;6980.197277313073;6983.580985140908;4176.812043458051;4385.232584297735;4420.359047938031;4486.170058539181;4533.070720502289;1103.5089385223578;1256.9245845249313;1258.1821815819699;1297.9480820767158;1309.4631201207555;16301.836981630151;16785.32858685651;16897.239624216818;16926.322947082102;16947.83052169475;5633.63381380209;5886;5959.0763431668165;6047.334793172748;6069.969650151721;12337.753244935051;12396.256224626552;12432.440540175532;12460;12483.812742808865;6644.235912870082;6696.531242812956;6703.497237707192;6715.059891615178;6721.386867151946;6013.939860601338;6170.444659980623;6192.783252586138;6262.248530176408;6267.905981410283;4378.255696531597;4503.797329120198;4530.116627257719;4537.183307004705;4561.794719237642;1256.384371657881;1335.859734727859;1343.9920059955034;1350.8581598932167;1354.6274774437109;764.75910088322;772.1699173388517;798.4690181029666;800.087899794235;808.6441965535263;6209.565330426827;6657.1012913257055;6697.397234248941;6765.458763298924;6977.825554361181;817.2685446525327;879.4371602174614;911.539672465414;911.8586619074055;958.324381311174;4006.338954072545;4179.393987871742;4197.3074442717225;4238.512571054368;4345.304751239786;14885.851141488447;15472.381104755908;15479.613009674847;15498.225088745743;15514.767278490832;14739.189344586151;15311;15330.463433779763;15409.922950385177;15437;7542.47202695806;8479.703210387606;8732.388732788771;8738.344624153215;8761.123887611315;6090.421409966046;6724.596524208563;6779.15260592426;6991.615461149686;7077.68150433242;12537.122401431812;12904.935475322563;12991.960643148337;13012.41444135035;13110.344482775632;13186.604401867959;13226.206427614374;13380.264085475392;13424;13478.86521134776;8178.795530111557;9567;9822.312438129262;9824.115829575372;9830.705078847646;8095.069067057364;10458.26792124544;10614;10775.299605525615;10785.083267922315;9223.591936224879;9231.261499080192;9293.581788819654;9312.627494900127;9358.970513243674;7538.718417868866;7586.013818203819;9079.45523268606;9096.818063638822;9140.817183656156;8135.349172066339;8201.58992050407;8229.218224268685;8292.58537073156;8304.83390332202;5980.162777211107;5989.341172471112;6031.215941927521;6157.138000679998;6188.566800323934;5696.1455781633085;6067.696615169136;6160.907586386297;6286.74853005893;6380.840478988062 10:36:16 INFO - PID 1632 | |4;prototype.html;408.2587763189994;408.324223410256;410.05073255413714;413.8323978788588;421.20602663978394;5325.068113080215;5460.31746031746;6280.403361680639;6414.422701956823;6425.9999999999945;5942.603488180274;6007.789727359544;6175.7529698811995;6256.84357891053;6279.6546189959645;4033.08428496464;4276.850310239142;4751.85744427666;4786.617070634358;4798;4654.883627909312;4763.951930575268;4789.305550695147;4803.589451489447;4805.399325084364;3564.5187899633606;4204.600562946515;4723.244280915054;4738.336632871401;4744.312074749159;4269.935950960754;4495;4717.858464246078;4718.528147185254;4730.911890265258;3616.8553257869653;4178.26880295947;4206.558311377323;4208.116295577933;4232.682548808852;4803.879903002418;5495.642783219078;5895.145203945447;6027.336992930774;6059.545534084961;4666.9066618667775;4676;5611.438856114397;5620.522255608278;5642.210090587321;6407.455366293871;6655.833604159886;6673.530793606348;6677.5325727199115;6718.563293385914;4108.712390132692;4674.7428891410955;4706.29405589161;4734.739589322586;4740.95259047412;5812.41347600318;5851.678157701324;6892.724291028353;6976.058232138698;7075.504714669975;3974.0129935032483;4232.470941132358;4505.324201369821;4540.523245059221;4561.817527298871;4605.088888111463;4621.69958952667;4626.768661566908;4633.328167415773;4644.698094623838;4752.643551733634;5148.871278218075;5412.050432514289;5435.42927992563;5541.196526503634;5333;6477.935220647827;6678.7662431815625;6711.429528490133;6743.2919543448215;1563.5934656989264;1582.2168026826794;1583.6753465539766;1583.8495342942401;1585.9603509912113;913.5295322908707;982.7960748083541;1149.9540018399337;1195.3784032303154;1227.4415141110774;5253.921191182136;6301.802657495061;6344.873102537924;6373.776917807947;6381.457576106083;5499.917501237484;6387.872242555216;6877.862442751217;6901;6949.722011119498;5643.379228284885;6160.476359509402;6252.874942501216;6446.452051575575;6447.838804029937;3197.904062878117;3278.1804548862783;3611.7674681160215;3615.94576081359;3631.891043268706;6869.862602747917;7191.64041797908;7220.4584656151;7248.043028382307;7253.419726421874;7080.398166155832;7171.063812770522;7178.4616153788675;7213.783586492414;7216.386607138347;6341.746330146742;6447.548671593037;6604.768833090915;6677.632730199788;6729.360710732375;6231.781887633911;6433.613983161025;6951.652417379009;6957.79126626202;6974.407175390149;6595.703193356215;6795.966020169867;6875.89686154698;6879.8968015480805;6906.620135892374;6350.76160148785;7040.260772618802;7090.822729431806;7108.46686498525;7315.48791584584;4560.4983451820935;4561.931571026371;4570.314452831969;4572.993941332901;4589.0363023765385;6424.967875160594;6571.245929802688;6888.690008949709;6942.687579059056;6984.615846128511;6049.576529642883;6066.787662431793;6723.932760672331;6729.831754206184;6734.797956061326;4899.485554016777;6266.777978294189;6322.146510221061;6610.206775186816;6652.310121364523;5449.6730196188355;6252.874942501216;6463;6530.183727034121;6542.83642908912;5478.137433272547;6009.759609615741;6595.845726997661;6696.397324240646;6743.831404214934;6090.482309003607;6361.681915904279;6440.32376600469;6446.64543450096;6484.610923344614 10:36:16 INFO - PID 1632 | |5;yui.html;822.8683410654296;838.3209600223819;838.9370797190211;861.3841103610919;862.8101817600126;16105.35578576857;16231.26959286832;16471.258793354296;17971.820281797212;18634.906825465852;17563.64872702545;17644.82355176448;17811.732824007617;17929.372471963485;18177.818441801275;954.5084281594984;967.1875624475439;968.1722127580922;968.6416026070364;970.4904924914441;970.9223262139012;975.1126474907835;978.0757184460688;979.2704435195789;984.9753756156117;1033.829418146005;1034.7826956339177;1040.0743338428804;1040.1834559870504;1040.8282633365523;1015.0103648942296;1030.2427715629044;1030.6753372687617;1031.6028329093278;1036.0364860679565;650.1418128070949;724.0623392706458;734.9963250183715;754.7660225330166;761.9847603047964;16191.91904040484;16245.268962896698;16353.672926541403;16426.42507512231;16510.75233871493;16100.516984490485;16587;16738.079405632685;16898.15509224534;16946.406875759414;11412.600558980479;13871.237081960488;13948.93025534876;13993.650158746012;14005.719885602333;3397.3884700753856;3507.386207413718;3525.876594319212;3535.1515636247113;3547.9290414191573;102538.97461025369;110074.44962775215;117256.99999999914;117584;119411.40294298473;13019.283939383235;13311.267880266678;13350.866491335157;13352.265625390502;13357.666058348424;24335.14826981047;25099.121530746335;25197.87401062983;25495.617565736156;25604.615930761054;7814.6874125034365;7915.287624113857;7921.247481489249;7924.841503169904;7925.841483170304;3914.080191155076;3971.5631280559114;4000.179963107556;4010.9598904010586;4016.8393264269685;4092.4653255029366;4278.2085314216965;4278.572142785759;4332.653387728974;4343.652507799368;844.0405099865012;890.9086369197681;946.8911075226437;948.4404201521136;953.0421925964362;618.1346115438332;623.8814625221194;654.2476152424749;656.9113169722121;674.0024763350171;10902.945485272523;11009.119270458345;11659.300441973339;11895.940520297516;11944.402779860971;605.4702135631322;620.7516993202755;632.1434456311723;646.5054233511273;660.4452260101538;5329.040772660958;5334.91997620036;5581.49766521015;5650.095984642519;5711.171880077365;105329.47335263275;107677.461612693;107875.46062269638;109716;110006.44996775125;68799.65600171968;89385.10614893898;91340.54329728441;91901;93574;84424;86278;86501;87019;87326;10127.64553240633;10503.527341269813;11238.719032024264;11434;11496.195266331277;41436.37845432261;41545.3381864722;41962.53131140395;42004.57995420007;42241.94395140146;53977;54625.72687136698;54874.72562637161;55020.24493876531;55402.72298638481;13577.389017494039;14113.576592702235;16959;16989.235484402983;17017.48947531576;18203.45389638313;18316;18384.356547520772;19008;19059.237630494627;16994;17395.82604173942;17534.210960507062;17629.20668569892;17693.734593980844;16455.588610284838;17507;17946;18254.72617910759;18309.267629295213;16030.599235019217;16293.429729959395;16591.91704041472;16656.833431665527;16695.49913502597;10643.467826608794;10659.733506662396;10851.565937362417;11632.418379081182;12336.013118950643;13692.452301907811;13879.861201388261;14029.438822446988;14057.929710351791;14061.648458788612 10:36:16 INFO - PID 1632 | __end_tp_report 10:36:16 INFO - PID 1632 | __start_cc_report 10:36:16 INFO - PID 1632 | _x_x_mozilla_cycle_collect,420 10:36:16 INFO - PID 1632 | __end_cc_report 10:36:16 INFO - PID 1632 | __startTimestamp1492796176963__endTimestamp 10:36:16 INFO - PID 1632 | 10:36:16 INFO - PID 1632 | ------- Summary: start ------- 10:36:16 INFO - PID 1632 | Number of tests: 6 10:36:16 INFO - PID 1632 | 10:36:16 INFO - PID 1632 | [#0] dojo.html Cycles:165 Average:6129.15 Median:6349.75 stddev:738.59 (11.6%) stddev-sans-first:707.65 10:36:16 INFO - PID 1632 | Values: 3337.6 3587.1 3608.2 3612.7 3660.5 6057.1 6222.9 6247.6 6257.5 6295.1 6126.5 6159.0 6181.0 6185.1 6312.5 5394.8 5500.6 5533.8 5596.6 5607.3 4851.9 5448.2 5483.8 5543.7 5590.0 5510.9 5524.9 5530.6 5556.2 5597.6 5331.8 5394.4 5403.6 5446.8 5514.9 5395.9 5405.1 5425.1 5438.9 5459.9 4947.3 5537.8 6198.8 6232.8 6241.4 6464.4 6598.2 6617.0 6703.5 6717.6 6796.4 6818.2 6836.6 6841.0 6857.7 6323.5 6341.9 6342.1 6344.8 6356.7 6578.4 6775.5 6833.9 6903.0 6978.4 6343.2 6543.3 6593.2 6635.9 6641.4 5608.3 6648.9 6652.3 6776.6 6813.8 6583.0 6614.2 6691.8 6721.5 6733.8 6396.0 6510.2 6533.2 6677.7 6717.6 5316.7 5355.5 5360.3 5372.0 5408.4 4713.6 4740.4 4744.2 4746.2 4780.1 6194.7 6219.9 6299.7 6349.7 6361.8 6704.1 6764.1 6785.0 6800.7 6811.9 6313.7 6328.3 6363.9 6382.7 6400.7 5766.4 5988.8 5992.4 6005.4 6016.2 6829.1 7000.9 7013.3 7048.9 7085.8 6060.5 6400.6 6819.9 6830.5 6831.4 5337.6 6074.8 6075.2 6762.8 6967.7 5553.5 6426.0 6530.2 6592.7 6648.4 6808.6 6820.4 6825.8 6832.4 6837.8 4735.6 6102.4 6580.8 6604.0 6613.3 5432.2 6516.3 6521.9 6577.2 6595.1 6324.8 6377.6 6447.9 6455.3 6459.5 6359.3 6565.7 6611.2 6615.7 6639.2 6206.6 6343.0 6402.6 6416.2 6443.6 10:36:16 INFO - PID 1632 | 10:36:16 INFO - PID 1632 | [#1] ext.html Cycles:180 Average:45338.64 Median:19007.97 stddev:79116.10 (416.2%) stddev-sans-first:79267.12 10:36:16 INFO - PID 1632 | Values: 722.8 801.9 819.0 1160.6 1253.3 36275.3 36896.4 37280.6 37348.1 37440.0 37549.0 37805.4 37836.6 37845.0 38023.6 7454.0 7808.1 7945.0 8012.2 8543.5 8398.4 8466.5 8482.8 8520.4 8528.8 8450.8 8499.0 8499.7 8510.3 8514.4 7215.5 8481.7 8483.9 8514.7 8523.3 8357.0 8406.7 8415.2 8423.0 8436.3 36710.8 36839.6 36853.6 37037.3 37064.4 3512.5 3525.6 3555.5 3556.8 3566.7 30271.8 30557.7 30623.2 30756.1 30858.0 3088.4 3123.4 3130.8 3133.6 3147.2 302048.0 302630.0 305150.0 309384.0 309825.0 47293.0 47791.5 47873.8 47881.8 47968.0 44846.8 50134.2 50233.7 54630.6 55286.9 14260.0 14398.8 14403.7 14411.7 14413.9 9316.7 11251.8 11503.9 11526.5 11565.7 14116.2 14127.5 14139.1 14145.5 14202.7 5247.9 6008.4 6153.6 6172.0 6205.5 912.9 973.6 1005.6 1032.4 1050.6 21152.7 23798.0 23900.9 24130.4 24345.8 1097.4 1100.7 1102.6 1139.2 1152.2 11613.4 12267.4 12311.7 12360.3 12432.8 306888.2 308640.9 309388.0 311847.0 324661.0 56060.0 56736.1 56752.1 56755.4 56756.7 1431.3 1465.7 1468.1 1473.9 1496.1 28609.6 29517.1 29850.0 30087.5 30243.7 37419.3 37573.0 37686.4 37722.4 37811.0 283858.0 285809.0 286619.0 287746.0 288196.0 34409.8 34503.4 35814.3 36392.8 36456.3 44641.6 45205.8 45437.1 45526.9 45599.3 22503.7 29237.4 29496.1 30650.0 31526.8 30165.8 30358.0 30533.4 30982.9 31203.7 36980.0 37092.0 37176.4 37242.0 37260.8 22825.0 23190.0 28746.9 29206.0 31121.7 22821.2 24631.8 24642.8 24728.6 24784.9 10:36:16 INFO - PID 1632 | 10:36:16 INFO - PID 1632 | [#2] jquery.html Cycles:180 Average:35524.52 Median:2277.15 stddev:92057.27 (4042.7%) stddev-sans-first:92277.81 10:36:16 INFO - PID 1632 | Values: 429.6 434.9 439.5 449.6 453.3 19338.1 20965.9 21679.8 21834.9 21908.7 21424.0 22378.6 22644.0 22727.9 22984.4 5915.0 6175.7 6180.6 6183.1 6195.7 5889.7 6174.9 6213.2 6214.3 6218.3 5264.8 5908.4 6108.5 6187.4 6192.3 6054.6 6083.8 6126.4 6161.0 6167.6 5280.3 5436.9 5459.9 5460.0 5486.6 26267.5 26781.2 27079.0 27720.6 28192.0 2232.8 2306.9 2309.6 2313.9 2317.8 15259.9 17220.4 17322.1 17738.5 17948.8 2040.2 2144.0 2175.2 2175.7 2182.6 152965.2 166008.2 168367.0 168905.0 169598.2 12579.0 12641.2 12911.7 12971.3 13055.1 16791.7 16828.9 16829.2 16851.3 16963.7 7354.2 9049.8 9076.5 9085.1 9251.0 7250.4 8552.7 8575.7 8613.7 8769.8 7868.8 7963.7 8017.8 8038.1 8041.4 2270.8 2276.4 2277.9 2299.3 2480.4 854.3 937.8 945.4 954.5 965.4 20101.7 20716.2 21328.9 21593.0 21787.0 988.4 1000.7 1016.5 1035.4 1035.6 10438.4 11089.7 11111.7 11168.2 13078.0 453893.0 551620.0 557203.0 557250.0 560453.0 136102.0 137352.3 139014.0 141422.0 142645.3 1183.7 1212.1 1239.4 1244.3 1245.3 15998.5 17150.8 21435.7 21657.4 22015.4 39230.6 56517.0 56743.7 57155.4 57525.0 51056.5 73613.5 75475.0 81516.6 82050.0 8344.9 8430.9 8984.6 9134.2 9136.5 10682.4 12737.7 13937.0 14072.0 14233.8 11581.0 11701.2 11814.2 11845.6 11946.8 10878.2 10894.7 11103.9 11295.6 11339.3 11461.5 11986.6 12013.4 12359.1 12413.9 8970.1 9080.9 9095.5 9160.4 9184.3 10079.5 10161.3 11882.2 12003.3 12159.5 10:36:16 INFO - PID 1632 | 10:36:16 INFO - PID 1632 | [#3] mootools.html Cycles:180 Average:7166.53 Median:4178.10 stddev:4521.78 (108.2%) stddev-sans-first:4511.92 10:36:16 INFO - PID 1632 | Values: 1158.6 1446.9 1452.8 1471.4 1479.6 10578.5 11222.8 11566.3 11862.8 12307.9 11689.5 11726.8 11879.9 11888.9 11909.3 2518.3 2533.3 2546.4 2550.1 2552.1 2477.5 2520.2 2555.8 2559.3 2563.4 2487.0 2523.2 2551.1 2552.1 2555.6 2369.5 2449.3 2522.7 2537.5 2547.0 2463.7 2520.8 2526.0 2534.9 2563.1 11770.9 11848.8 11937.9 11941.8 11951.4 6702.1 6970.6 6972.1 6980.2 6983.6 4176.8 4385.2 4420.4 4486.2 4533.1 1103.5 1256.9 1258.2 1297.9 1309.5 16301.8 16785.3 16897.2 16926.3 16947.8 5633.6 5886.0 5959.1 6047.3 6070.0 12337.8 12396.3 12432.4 12460.0 12483.8 6644.2 6696.5 6703.5 6715.1 6721.4 6013.9 6170.4 6192.8 6262.2 6267.9 4378.3 4503.8 4530.1 4537.2 4561.8 1256.4 1335.9 1344.0 1350.9 1354.6 764.8 772.2 798.5 800.1 808.6 6209.6 6657.1 6697.4 6765.5 6977.8 817.3 879.4 911.5 911.9 958.3 4006.3 4179.4 4197.3 4238.5 4345.3 14885.9 15472.4 15479.6 15498.2 15514.8 14739.2 15311.0 15330.5 15409.9 15437.0 7542.5 8479.7 8732.4 8738.3 8761.1 6090.4 6724.6 6779.2 6991.6 7077.7 12537.1 12904.9 12992.0 13012.4 13110.3 13186.6 13226.2 13380.3 13424.0 13478.9 8178.8 9567.0 9822.3 9824.1 9830.7 8095.1 10458.3 10614.0 10775.3 10785.1 9223.6 9231.3 9293.6 9312.6 9359.0 7538.7 7586.0 9079.5 9096.8 9140.8 8135.3 8201.6 8229.2 8292.6 8304.8 5980.2 5989.3 6031.2 6157.1 6188.6 5696.1 6067.7 6160.9 6286.7 6380.8 10:36:16 INFO - PID 1632 | 10:36:16 INFO - PID 1632 | [#4] prototype.html Cycles:180 Average:5372.33 Median:6038.46 stddev:1671.66 (27.7%) stddev-sans-first:1634.30 10:36:16 INFO - PID 1632 | Values: 408.3 408.3 410.1 413.8 421.2 5325.1 5460.3 6280.4 6414.4 6426.0 5942.6 6007.8 6175.8 6256.8 6279.7 4033.1 4276.9 4751.9 4786.6 4798.0 4654.9 4764.0 4789.3 4803.6 4805.4 3564.5 4204.6 4723.2 4738.3 4744.3 4269.9 4495.0 4717.9 4718.5 4730.9 3616.9 4178.3 4206.6 4208.1 4232.7 4803.9 5495.6 5895.1 6027.3 6059.5 4666.9 4676.0 5611.4 5620.5 5642.2 6407.5 6655.8 6673.5 6677.5 6718.6 4108.7 4674.7 4706.3 4734.7 4741.0 5812.4 5851.7 6892.7 6976.1 7075.5 3974.0 4232.5 4505.3 4540.5 4561.8 4605.1 4621.7 4626.8 4633.3 4644.7 4752.6 5148.9 5412.1 5435.4 5541.2 5333.0 6477.9 6678.8 6711.4 6743.3 1563.6 1582.2 1583.7 1583.8 1586.0 913.5 982.8 1150.0 1195.4 1227.4 5253.9 6301.8 6344.9 6373.8 6381.5 5499.9 6387.9 6877.9 6901.0 6949.7 5643.4 6160.5 6252.9 6446.5 6447.8 3197.9 3278.2 3611.8 3615.9 3631.9 6869.9 7191.6 7220.5 7248.0 7253.4 7080.4 7171.1 7178.5 7213.8 7216.4 6341.7 6447.5 6604.8 6677.6 6729.4 6231.8 6433.6 6951.7 6957.8 6974.4 6595.7 6796.0 6875.9 6879.9 6906.6 6350.8 7040.3 7090.8 7108.5 7315.5 4560.5 4561.9 4570.3 4573.0 4589.0 6425.0 6571.2 6888.7 6942.7 6984.6 6049.6 6066.8 6723.9 6729.8 6734.8 4899.5 6266.8 6322.1 6610.2 6652.3 5449.7 6252.9 6463.0 6530.2 6542.8 5478.1 6009.8 6595.8 6696.4 6743.8 6090.5 6361.7 6440.3 6446.6 6484.6 10:36:16 INFO - PID 1632 | 10:36:16 INFO - PID 1632 | [#5] yui.html Cycles:180 Average:21602.31 Median:18350.18 stddev:29893.67 (162.9%) stddev-sans-first:29936.81 10:36:16 INFO - PID 1632 | Values: 822.9 838.3 838.9 861.4 862.8 16105.4 16231.3 16471.3 17971.8 18634.9 17563.6 17644.8 17811.7 17929.4 18177.8 954.5 967.2 968.2 968.6 970.5 970.9 975.1 978.1 979.3 985.0 1033.8 1034.8 1040.1 1040.2 1040.8 1015.0 1030.2 1030.7 1031.6 1036.0 650.1 724.1 735.0 754.8 762.0 16191.9 16245.3 16353.7 16426.4 16510.8 16100.5 16587.0 16738.1 16898.2 16946.4 11412.6 13871.2 13948.9 13993.7 14005.7 3397.4 3507.4 3525.9 3535.2 3547.9 102539.0 110074.4 117257.0 117584.0 119411.4 13019.3 13311.3 13350.9 13352.3 13357.7 24335.1 25099.1 25197.9 25495.6 25604.6 7814.7 7915.3 7921.2 7924.8 7925.8 3914.1 3971.6 4000.2 4011.0 4016.8 4092.5 4278.2 4278.6 4332.7 4343.7 844.0 890.9 946.9 948.4 953.0 618.1 623.9 654.2 656.9 674.0 10902.9 11009.1 11659.3 11895.9 11944.4 605.5 620.8 632.1 646.5 660.4 5329.0 5334.9 5581.5 5650.1 5711.2 105329.5 107677.5 107875.5 109716.0 110006.4 68799.7 89385.1 91340.5 91901.0 93574.0 84424.0 86278.0 86501.0 87019.0 87326.0 10127.6 10503.5 11238.7 11434.0 11496.2 41436.4 41545.3 41962.5 42004.6 42241.9 53977.0 54625.7 54874.7 55020.2 55402.7 13577.4 14113.6 16959.0 16989.2 17017.5 18203.5 18316.0 18384.4 19008.0 19059.2 16994.0 17395.8 17534.2 17629.2 17693.7 16455.6 17507.0 17946.0 18254.7 18309.3 16030.6 16293.4 16591.9 16656.8 16695.5 10643.5 10659.7 10851.6 11632.4 12336.0 13692.5 13879.9 14029.4 14057.9 14061.6 10:36:16 INFO - PID 1632 | -------- Summary: end -------- 10:36:16 INFO - PID 1632 | 10:36:17 INFO - TEST-INFO | 1632: exit 0 10:36:17 INFO - TEST-OK | dromaeo_css | took 1115636ms 10:36:17 INFO - TEST-START | kraken 10:36:17 INFO - operating with platform_type : mac_ 10:36:17 INFO - Initialising browser for kraken test... 10:36:17 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/tmpSFwAug/profile http://localhost:49243/getInfo.html) 10:36:20 INFO - PID 1644 | 2017-04-21 10:36:20.416 plugin-container[1645:10151] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x913f, name = 'com.apple.tsm.portname' 10:36:20 INFO - PID 1644 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:36:20 INFO - PID 1644 | 2017-04-21 10:36:20.419 plugin-container[1645:10151] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x960f, name = 'com.apple.CFPasteboardClient' 10:36:20 INFO - PID 1644 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:36:20 INFO - PID 1644 | 2017-04-21 10:36:20.419 plugin-container[1645:10151] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:36:20 INFO - PID 1644 | __metrics Screen width/height:1600/1200 10:36:20 INFO - PID 1644 | colorDepth:24 10:36:20 INFO - PID 1644 | Browser inner width/height: 1024/689 10:36:20 INFO - PID 1644 | __metrics 10:36:20 ERROR - PID 1644 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3403: TypeError: this.tabs is undefined 10:36:21 INFO - TEST-INFO | 1644: exit 0 10:36:21 INFO - Browser initialized. 10:36:21 INFO - Running cycle 1/1 for kraken test... 10:36:21 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/tmpSFwAug/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:36:23 INFO - PID 1646 | 2017-04-21 10:36:23.940 plugin-container[1647:10284] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x913f, name = 'com.apple.tsm.portname' 10:36:23 INFO - PID 1646 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:36:23 INFO - PID 1646 | 2017-04-21 10:36:23.940 plugin-container[1647:10284] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x970f, name = 'com.apple.CFPasteboardClient' 10:36:23 INFO - PID 1646 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:36:23 INFO - PID 1646 | 2017-04-21 10:36:23.940 plugin-container[1647:10284] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:36:33 INFO - PID 1646 | RSS: Main: 236507136 10:36:33 INFO - PID 1646 | 10:36:36 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 10:36:37 INFO - PID 1646 | RSS: Main: 249401344 10:36:37 INFO - PID 1646 | 10:36:39 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 10:36:40 INFO - PID 1646 | RSS: Main: 257507328 10:36:40 INFO - PID 1646 | 10:36:44 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 10:36:44 INFO - PID 1646 | RSS: Main: 259813376 10:36:44 INFO - PID 1646 | 10:36:46 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 10:36:47 INFO - PID 1646 | RSS: Main: 260866048 10:36:47 INFO - PID 1646 | 10:36:49 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:36:49 INFO - PID 1646 | RSS: Main: 262881280 10:36:49 INFO - PID 1646 | 10:36:52 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 10:36:53 INFO - PID 1646 | RSS: Main: 268386304 10:36:53 INFO - PID 1646 | 10:36:56 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 10:36:57 INFO - PID 1646 | RSS: Main: 270008320 10:36:57 INFO - PID 1646 | 10:37:00 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 10:37:01 INFO - PID 1646 | RSS: Main: 269402112 10:37:01 INFO - PID 1646 | 10:37:02 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:37:03 INFO - PID 1646 | RSS: Main: 268513280 10:37:03 INFO - PID 1646 | 10:37:04 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:37:05 INFO - PID 1646 | RSS: Main: 268591104 10:37:05 INFO - PID 1646 | 10:37:07 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:37:08 INFO - PID 1646 | RSS: Main: 268140544 10:37:08 INFO - PID 1646 | 10:37:11 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:37:12 INFO - PID 1646 | RSS: Main: 268402688 10:37:12 INFO - PID 1646 | 10:37:15 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:37:15 INFO - PID 1646 | RSS: Main: 268476416 10:37:15 INFO - PID 1646 | 10:37:17 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 10:37:17 INFO - PID 1646 | RSS: Main: 270286848 10:37:17 INFO - PID 1646 | 10:37:17 INFO - PID 1646 | __start_tp_report 10:37:17 INFO - PID 1646 | _x_x_mozilla_page_load 10:37:17 INFO - PID 1646 | _x_x_mozilla_page_load_details 10:37:17 INFO - PID 1646 | |i|pagename|runs| 10:37:17 INFO - PID 1646 | |0;ai-astar;110;114;116;115;114;115;115;115;114;115 10:37:17 INFO - PID 1646 | |1;audio-beat-detection;142;115;122;149;99;106;143;149;163;115 10:37:17 INFO - PID 1646 | |2;audio-dft;197;203;196;207;214;288;209;285;259;198 10:37:17 INFO - PID 1646 | |3;audio-fft;84;58;65;100;91;85;58;63;78;59 10:37:17 INFO - PID 1646 | |4;audio-oscillator;84;70;83;72;73;71;90;68;88;94 10:37:17 INFO - PID 1646 | |5;imaging-gaussian-blur;89;90;96;90;90;90;89;91;91;89 10:37:17 INFO - PID 1646 | |6;imaging-darkroom;110;115;98;98;109;97;105;93;148;156 10:37:17 INFO - PID 1646 | |7;imaging-desaturate;92;92;89;91;96;126;77;142;151;136 10:37:17 INFO - PID 1646 | |8;json-parse-financial;52;50;51;53;52;52;53;53;52;52 10:37:17 INFO - PID 1646 | |9;json-stringify-tinderbox;59;66;60;57;69;64;58;58;56;59 10:37:17 INFO - PID 1646 | |10;stanford-crypto-aes;83;82;83;73;94;107;114;108;83;85 10:37:17 INFO - PID 1646 | |11;stanford-crypto-ccm;147;146;146;138;141;136;140;144;204;153 10:37:17 INFO - PID 1646 | |12;stanford-crypto-pbkdf2;182;187;184;185;232;232;190;186;189;183 10:37:17 INFO - PID 1646 | |13;stanford-crypto-sha256-iterative;69;68;69;69;69;70;68;69;68;68 10:37:17 INFO - PID 1646 | __end_tp_report 10:37:17 INFO - PID 1646 | __start_cc_report 10:37:17 INFO - PID 1646 | _x_x_mozilla_cycle_collect,996 10:37:17 INFO - PID 1646 | __end_cc_report 10:37:17 INFO - PID 1646 | __startTimestamp1492796237822__endTimestamp 10:37:17 INFO - PID 1646 | 10:37:17 INFO - PID 1646 | ------- Summary: start ------- 10:37:17 INFO - PID 1646 | Number of tests: 14 10:37:17 INFO - PID 1646 | 10:37:17 INFO - PID 1646 | [#0] ai-astar Cycles:10 Average:114.30 Median:115.00 stddev:1.64 (1.4%) stddev-sans-first:0.67 10:37:17 INFO - PID 1646 | Values: 110.0 114.0 116.0 115.0 114.0 115.0 115.0 115.0 114.0 115.0 10:37:17 INFO - PID 1646 | 10:37:17 INFO - PID 1646 | [#1] audio-beat-detection Cycles:10 Average:130.30 Median:146.00 stddev:21.54 (14.8%) stddev-sans-first:22.42 10:37:17 INFO - PID 1646 | Values: 142.0 115.0 122.0 149.0 99.0 106.0 143.0 149.0 163.0 115.0 10:37:17 INFO - PID 1646 | 10:37:17 INFO - PID 1646 | [#2] audio-dft Cycles:10 Average:225.60 Median:211.50 stddev:36.91 (17.5%) stddev-sans-first:37.67 10:37:17 INFO - PID 1646 | Values: 197.0 203.0 196.0 207.0 214.0 288.0 209.0 285.0 259.0 198.0 10:37:17 INFO - PID 1646 | 10:37:17 INFO - PID 1646 | [#3] audio-fft Cycles:10 Average:74.10 Median:71.50 stddev:15.42 (21.6%) stddev-sans-first:15.94 10:37:17 INFO - PID 1646 | Values: 84.0 58.0 65.0 100.0 91.0 85.0 58.0 63.0 78.0 59.0 10:37:17 INFO - PID 1646 | 10:37:17 INFO - PID 1646 | [#4] audio-oscillator Cycles:10 Average:79.30 Median:83.50 stddev:9.53 (11.4%) stddev-sans-first:9.96 10:37:17 INFO - PID 1646 | Values: 84.0 70.0 83.0 72.0 73.0 71.0 90.0 68.0 88.0 94.0 10:37:17 INFO - PID 1646 | 10:37:17 INFO - PID 1646 | [#5] imaging-gaussian-blur Cycles:10 Average:90.50 Median:90.00 stddev:2.07 (2.3%) stddev-sans-first:2.12 10:37:17 INFO - PID 1646 | Values: 89.0 90.0 96.0 90.0 90.0 90.0 89.0 91.0 91.0 89.0 10:37:17 INFO - PID 1646 | 10:37:17 INFO - PID 1646 | [#6] imaging-darkroom Cycles:10 Average:112.90 Median:124.50 stddev:21.79 (17.5%) stddev-sans-first:23.09 10:37:17 INFO - PID 1646 | Values: 110.0 115.0 98.0 98.0 109.0 97.0 105.0 93.0 148.0 156.0 10:37:17 INFO - PID 1646 | 10:37:17 INFO - PID 1646 | [#7] imaging-desaturate Cycles:10 Average:109.20 Median:90.00 stddev:26.59 (29.5%) stddev-sans-first:27.47 10:37:17 INFO - PID 1646 | Values: 92.0 92.0 89.0 91.0 96.0 126.0 77.0 142.0 151.0 136.0 10:37:17 INFO - PID 1646 | 10:37:17 INFO - PID 1646 | [#8] json-parse-financial Cycles:10 Average:52.00 Median:52.00 stddev:0.94 (1.8%) stddev-sans-first:1.00 10:37:17 INFO - PID 1646 | Values: 52.0 50.0 51.0 53.0 52.0 52.0 53.0 53.0 52.0 52.0 10:37:17 INFO - PID 1646 | 10:37:17 INFO - PID 1646 | [#9] json-stringify-tinderbox Cycles:10 Average:60.60 Median:59.50 stddev:4.27 (7.2%) stddev-sans-first:4.49 10:37:17 INFO - PID 1646 | Values: 59.0 66.0 60.0 57.0 69.0 64.0 58.0 58.0 56.0 59.0 10:37:17 INFO - PID 1646 | 10:37:17 INFO - PID 1646 | [#10] stanford-crypto-aes Cycles:10 Average:91.20 Median:83.00 stddev:13.81 (16.6%) stddev-sans-first:14.32 10:37:17 INFO - PID 1646 | Values: 83.0 82.0 83.0 73.0 94.0 107.0 114.0 108.0 83.0 85.0 10:37:17 INFO - PID 1646 | 10:37:17 INFO - PID 1646 | [#11] stanford-crypto-ccm Cycles:10 Average:149.50 Median:146.00 stddev:19.78 (13.5%) stddev-sans-first:20.96 10:37:17 INFO - PID 1646 | Values: 147.0 146.0 146.0 138.0 141.0 136.0 140.0 144.0 204.0 153.0 10:37:17 INFO - PID 1646 | 10:37:17 INFO - PID 1646 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:195.00 Median:188.00 stddev:19.66 (10.5%) stddev-sans-first:20.28 10:37:17 INFO - PID 1646 | Values: 182.0 187.0 184.0 185.0 232.0 232.0 190.0 186.0 189.0 183.0 10:37:17 INFO - PID 1646 | 10:37:17 INFO - PID 1646 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 10:37:17 INFO - PID 1646 | Values: 69.0 68.0 69.0 69.0 69.0 70.0 68.0 69.0 68.0 68.0 10:37:17 INFO - PID 1646 | -------- Summary: end -------- 10:37:17 INFO - PID 1646 | 10:37:19 INFO - TEST-INFO | 1646: exit 0 10:37:19 INFO - TEST-OK | kraken | took 61351ms 10:37:19 INFO - SUITE-END | took 1176s 10:37:19 INFO - Completed test suite (00:19:37) 10:37:19 INFO - javascript benchmark 10:37:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7912.424520481172, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3337.6161741399733, 3587.1032241939515, 3608.1520842602, 3612.6929211017064, 3660.469231961365, 6057.121717350981, 6222.875542489153, 6247.593906396087, 6257.4994000479965, 6295.118683384329, 6126.4871384639955, 6158.983767678328, 6181.0, 6185.072239164117, 6312.495000399968, 5394.7842086316505, 5500.5874559408, 5533.833984980457, 5596.552275817925, 5607.327120745516, 4851.902961940777, 5448.210009548613, 5483.7806487740445, 5543.695096769676, 5589.972050139743, 5510.862228444281, 5524.944750552483, 5530.5852061095575, 5556.249906262663, 5597.608167428281, 5331.786728530854, 5394.379646340682, 5403.567714582824, 5446.754896029688, 5514.862128446781, 5395.919061214085, 5405.135178371481, 5425.050616142199, 5438.945610543883, 5459.918101228445, 4947.257911313296, 5537.750801213915, 6198.81403557894, 6232.813015609494, 6241.438270555626, 6464.385883341075, 6598.208215014229, 6616.966915165442, 6703.463722902205, 6717.63053032083, 6796.388325050769, 6818.2159051709195, 6836.589804611739, 6840.965795170992, 6857.657117144123, 6323.52573556985, 6341.936580634227, 6342.112104305401, 6344.777932772331, 6356.71394787231, 6578.375054369827, 6775.4918381121615, 6833.863322733518, 6902.965485172542, 6978.441724662015, 6343.238811342669, 6543.280239173687, 6593.208814942238, 6635.9336406636285, 6641.435477984425, 5608.298962629671, 6648.900266496006, 6652.334766523309, 6776.593404395752, 6813.7955861324235, 6582.967085164543, 6614.206295244505, 6691.832704182434, 6721.462283017347, 6733.764318248838, 6395.968020159869, 6510.21877374718, 6533.24867640218, 6677.699503522354, 6717.596944183365, 5316.6544174628525, 5355.518003379714, 5360.276362690986, 5371.973140134352, 5408.378036525771, 4713.575778179912, 4740.407449068866, 4744.217204161344, 4746.1931471649905, 4780.11567859947, 6194.659293738888, 6219.906701399483, 6299.653519056405, 6349.746010159542, 6361.840953976095, 6704.128463299739, 6764.120664313607, 6784.98225266214, 6800.65996700163, 6811.897821532681, 6313.652749098844, 6328.272248691459, 6363.936360636334, 6382.712777925005, 6400.7119679614525, 5766.394528574523, 5988.790392336247, 5992.370801065913, 6005.429484198994, 6016.2479690038745, 6829.078074459983, 7000.859982800213, 7013.263607321158, 7048.894266586108, 7085.82285442868, 6060.545459090497, 6400.583962042452, 6819.897701534382, 6830.45356371499, 6831.419329356861, 5337.599680023936, 6074.785042991508, 6075.2405949256345, 6762.797116086525, 6967.686454109476, 5553.527950124285, 6426.003969384753, 6530.183727034121, 6592.67036648156, 6648.434883034803, 6808.5914845109455, 6820.35206655367, 6825.795226143224, 6832.385085342343, 6837.760678376233, 4735.550122738335, 6102.420270074336, 6580.80257592273, 6603.966980165261, 6613.27254002069, 5432.2123292123215, 6516.315786842313, 6521.934780652323, 6577.2436169841085, 6595.109660196004, 6324.778632747832, 6377.585456945284, 6447.935520644921, 6455.289918109098, 6459.4832413405875, 6359.332270111571, 6565.704543295658, 6611.206655201407, 6615.702293396905, 6639.236487803964, 6206.565540412308, 6343.0485427186295, 6402.647854368054, 6416.165898433173, 6443.6455994920725], "value": 6082.5236986086975, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [722.8409749855033, 801.9077806052303, 819.0499021135482, 1160.6344001639477, 1253.2981530343009, 36275.27449451009, 36896.44655330169, 37280.627193728054, 37348.066298342485, 37440.0, 37549.0, 37805.432918506245, 37836.62163378365, 37845.0, 38023.61976380235, 7454.030975973143, 7808.141104478503, 7945.0, 8012.238837310446, 8543.530105844176, 8398.412111152222, 8466.534340611295, 8482.830343393129, 8520.40357174998, 8528.78678033048, 8450.830983380329, 8499.0, 8499.660013599449, 8510.276626486757, 8514.446560973547, 7215.530990485601, 8481.703140390087, 8483.872741908875, 8514.70198543048, 8523.275521580643, 8356.958215208946, 8406.663733450654, 8415.158484151598, 8422.957885210595, 8436.282915952152, 36710.816445917866, 36839.63160368389, 36853.63146368555, 37037.25925481475, 37064.444033339525, 3512.4906888501278, 3525.629808870083, 3555.520004799345, 3556.822158892045, 3566.732495062881, 30271.848640756874, 30557.694423055706, 30623.2344191397, 30756.077317680505, 30858.0, 3088.3977624363256, 3123.3597112591865, 3130.843457827122, 3133.6239651242, 3147.244661281276, 302048.0, 302630.0, 305150.0, 309383.99999999773, 309825.0, 47293.0, 47791.522084779404, 47873.76063119732, 47881.8029549264, 47968.04063918702, 44846.77576612162, 50134.247986280236, 50233.748831256344, 54630.63423414446, 55286.89426211534, 14260.0, 14398.784018239734, 14403.711925761427, 14411.711765764627, 14413.927930360282, 9316.720498385059, 11251.774964500828, 11503.907128822748, 11526.538938442536, 11565.710857228636, 14116.153030818185, 14127.505537306144, 14139.08095973779, 14145.504907328193, 14202.715945681235, 5247.947520524822, 6008.399160084044, 6153.630782153085, 6171.981623032239, 6205.503559715212, 912.9360944733937, 973.5862258540092, 1005.607812952949, 1032.3702541449709, 1050.56926660069, 21152.682709759367, 23798.04807807703, 23900.880495597412, 24130.396740081287, 24345.835041444854, 1097.3964319624174, 1100.7138144082596, 1102.6030628973563, 1139.168407062832, 1152.1646806065535, 11613.419329033515, 12267.38663066843, 12311.69220769488, 12360.25838449696, 12432.813507797391, 306888.17341919115, 308640.91359086573, 309388.0, 311847.0, 324661.0, 56060.0, 56736.14895776567, 56752.14871776927, 56755.43244567502, 56756.71621641865, 1431.291510702209, 1465.6922046370382, 1468.1484738851655, 1473.8526147385176, 1496.0500082447725, 28609.570856437585, 29517.11448656544, 29850.0, 30087.548686769278, 30243.69756302409, 37419.251614967005, 37573.0, 37686.434703478924, 37722.43416348812, 37811.0, 283858.0, 285809.0, 286619.0, 287746.0, 288196.0, 34409.82795086008, 34503.447344870045, 35814.28371432609, 36392.81803590965, 36456.27087458183, 44641.55358446374, 45205.77397112994, 45437.091258175315, 45526.86182845455, 45599.31601026054, 22503.662445063008, 29237.415251694423, 29496.115116546538, 30650.0, 31526.842365788023, 30165.849170754005, 30358.0, 30533.389332213676, 30982.915597954867, 31203.68796312008, 36980.0, 37092.0, 37176.44235336526, 37242.0, 37260.81369593135, 22825.0, 23189.956451959366, 28746.85626571854, 29206.0, 31121.688783112786, 22821.20125795589, 24631.753682463663, 24642.753572464047, 24728.629070563595, 24784.876075619508], "value": 17535.203865954903, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [429.6262251840899, 434.8586709319471, 439.457270271215, 449.5976101389257, 453.25439651772854, 19338.12978415973, 20965.895170524145, 21679.80761058141, 21834.908254587288, 21908.671369929445, 21424.0, 22378.55242895141, 22644.0, 22727.886360568173, 22984.425389365275, 5914.970425147879, 6175.691215439232, 6180.6291622502795, 6183.103449999748, 6195.721192546323, 5889.734961926702, 6174.9073763893575, 6213.161223234873, 6214.254289485268, 6218.347073557279, 5264.8157314494, 5908.350081491054, 6108.541859360544, 6187.412195841388, 6192.349803270659, 6054.576179667403, 6083.756649734005, 6126.356732543108, 6160.969195153995, 6167.599106058115, 5280.287161233223, 5436.945630543683, 5459.918101228484, 5459.972700136514, 5486.561075113981, 26267.474650507073, 26781.196564102913, 27079.0, 27720.584191236947, 28192.0, 2232.7767223277706, 2306.850054746436, 2309.56118337517, 2313.90744370225, 2317.826163037762, 15259.923700381427, 17220.397286094925, 17322.133893305283, 17738.467845964642, 17948.820511794846, 2040.1737296394983, 2143.9816087358536, 2175.2277941330917, 2175.684525743774, 2182.6071307164702, 152965.23517382453, 166008.16995915063, 168367.0, 168905.0, 169598.1520092404, 12579.0, 12641.178323408949, 12911.741765164645, 12971.286579238043, 13055.086143969831, 16791.748123778154, 16828.915855420888, 16829.158542072848, 16851.325946961984, 16963.66072678564, 7354.227806080285, 9049.77375565603, 9076.500792456347, 9085.091490850995, 9251.011032628017, 7250.383717383976, 8552.700655477029, 8575.656973720981, 8613.69852055175, 8769.824603507894, 7868.803279918048, 7963.6814527418255, 8017.759467215993, 8038.075621303508, 8041.356691464669, 2270.8296877734238, 2276.430892276931, 2277.8633282003134, 2299.2872209615075, 2480.3923038855596, 854.256796586961, 937.8077494113691, 945.4043952310001, 954.4559601027348, 965.4159233663532, 20101.698474522895, 20716.171353145706, 21328.893355533124, 21593.02831372592, 21787.0, 988.3723835364596, 1000.7448100734412, 1016.5273147986074, 1035.3529044347283, 1035.6219979707353, 10438.425886576311, 11089.722756931142, 11111.72023343767, 11168.162387820947, 13078.019148563895, 453893.0, 551620.0, 557203.0, 557250.0, 560453.0, 136102.0, 137352.31323843315, 139014.0, 141422.0, 142645.28677356755, 1183.7336599265097, 1212.0667086343467, 1239.429862263351, 1244.3031902134833, 1245.2839617220134, 15998.520044398687, 17150.7994440388, 21435.67846482273, 21657.350279491642, 22015.449613759145, 39230.607693923834, 56517.0, 56743.716281419984, 57155.42844571667, 57525.0, 51056.46830595088, 73613.52772944618, 75475.0, 81516.59241703754, 82050.0, 8344.87482687748, 8430.873536896828, 8984.595693193953, 9134.22359099484, 9136.49749263797, 10682.359058456517, 12737.745245095231, 13937.0, 14072.014958952775, 14233.786493202817, 11581.0, 11701.180917335705, 11814.232074915102, 11845.644630661094, 11946.761064778482, 10878.238523303293, 10894.67315980522, 11103.944480277547, 11295.604653837076, 11339.262947908359, 11461.541538338373, 11986.64040078799, 12013.399330033288, 12359.134860559674, 12413.937930310653, 8970.102989700978, 9080.90919090827, 9095.454272743656, 9160.358774885693, 9184.265258779415, 10079.496025198565, 10161.288709790244, 11882.227655202385, 12003.319535265244, 12159.452824622736], "value": 10464.471802603068, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1158.6292386436342, 1446.9059511131782, 1452.8038714773515, 1471.3599584180881, 1479.6153000219942, 10578.471076446185, 11222.831657525123, 11566.306021638697, 11862.822057669131, 12307.876921230785, 11689.532418703264, 11726.77191333646, 11879.940600297008, 11888.881111188886, 11909.285442873412, 2518.3326418499114, 2533.3413312538687, 2546.3506805764505, 2550.1457011901034, 2552.055739376424, 2477.479729256849, 2520.243926821955, 2555.7955363570964, 2559.308986573624, 2563.38478765096, 2487.0, 2523.1925783749207, 2551.094361501668, 2552.0812507497285, 2555.642210090589, 2369.5024044950583, 2449.2774631483753, 2522.72250052495, 2537.517871604408, 2546.9939373947186, 2463.728989811137, 2520.790020790013, 2525.9621105683245, 2534.936626584332, 2563.0644814642706, 11770.882291177064, 11848.822267665992, 11937.880621193764, 11941.761164776743, 11951.402429878472, 6702.095217145672, 6970.616616086113, 6972.058772065757, 6980.197277313073, 6983.580985140908, 4176.812043458051, 4385.232584297735, 4420.359047938031, 4486.170058539181, 4533.070720502289, 1103.5089385223578, 1256.9245845249313, 1258.1821815819699, 1297.9480820767158, 1309.4631201207555, 16301.836981630151, 16785.32858685651, 16897.239624216818, 16926.322947082102, 16947.83052169475, 5633.63381380209, 5886.0, 5959.0763431668165, 6047.334793172748, 6069.969650151721, 12337.753244935051, 12396.256224626552, 12432.440540175532, 12460.0, 12483.812742808865, 6644.235912870082, 6696.531242812956, 6703.497237707192, 6715.059891615178, 6721.386867151946, 6013.939860601338, 6170.444659980623, 6192.783252586138, 6262.248530176408, 6267.905981410283, 4378.255696531597, 4503.797329120198, 4530.116627257719, 4537.183307004705, 4561.794719237642, 1256.384371657881, 1335.859734727859, 1343.9920059955034, 1350.8581598932167, 1354.6274774437109, 764.75910088322, 772.1699173388517, 798.4690181029666, 800.087899794235, 808.6441965535263, 6209.565330426827, 6657.1012913257055, 6697.397234248941, 6765.458763298924, 6977.825554361181, 817.2685446525327, 879.4371602174614, 911.539672465414, 911.8586619074055, 958.324381311174, 4006.338954072545, 4179.393987871742, 4197.3074442717225, 4238.512571054368, 4345.304751239786, 14885.851141488447, 15472.381104755908, 15479.613009674847, 15498.225088745743, 15514.767278490832, 14739.189344586151, 15311.0, 15330.463433779763, 15409.922950385177, 15437.0, 7542.47202695806, 8479.703210387606, 8732.388732788771, 8738.344624153215, 8761.123887611315, 6090.421409966046, 6724.596524208563, 6779.15260592426, 6991.615461149686, 7077.68150433242, 12537.122401431812, 12904.935475322563, 12991.960643148337, 13012.41444135035, 13110.344482775632, 13186.604401867959, 13226.206427614374, 13380.264085475392, 13424.0, 13478.86521134776, 8178.795530111557, 9567.0, 9822.312438129262, 9824.115829575372, 9830.705078847646, 8095.069067057364, 10458.26792124544, 10614.0, 10775.299605525615, 10785.083267922315, 9223.591936224879, 9231.261499080192, 9293.581788819654, 9312.627494900127, 9358.970513243674, 7538.718417868866, 7586.013818203819, 9079.45523268606, 9096.818063638822, 9140.817183656156, 8135.349172066339, 8201.58992050407, 8229.218224268685, 8292.58537073156, 8304.83390332202, 5980.162777211107, 5989.341172471112, 6031.215941927521, 6157.138000679998, 6188.566800323934, 5696.1455781633085, 6067.696615169136, 6160.907586386297, 6286.74853005893, 6380.840478988062], "value": 5428.967719657337, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [408.2587763189994, 408.324223410256, 410.05073255413714, 413.8323978788588, 421.20602663978394, 5325.068113080215, 5460.31746031746, 6280.403361680639, 6414.422701956823, 6425.9999999999945, 5942.603488180274, 6007.789727359544, 6175.7529698811995, 6256.84357891053, 6279.6546189959645, 4033.08428496464, 4276.850310239142, 4751.85744427666, 4786.617070634358, 4798.0, 4654.883627909312, 4763.951930575268, 4789.305550695147, 4803.589451489447, 4805.399325084364, 3564.5187899633606, 4204.600562946515, 4723.244280915054, 4738.336632871401, 4744.312074749159, 4269.935950960754, 4495.0, 4717.858464246078, 4718.528147185254, 4730.911890265258, 3616.8553257869653, 4178.26880295947, 4206.558311377323, 4208.116295577933, 4232.682548808852, 4803.879903002418, 5495.642783219078, 5895.145203945447, 6027.336992930774, 6059.545534084961, 4666.9066618667775, 4676.0, 5611.438856114397, 5620.522255608278, 5642.210090587321, 6407.455366293871, 6655.833604159886, 6673.530793606348, 6677.5325727199115, 6718.563293385914, 4108.712390132692, 4674.7428891410955, 4706.29405589161, 4734.739589322586, 4740.95259047412, 5812.41347600318, 5851.678157701324, 6892.724291028353, 6976.058232138698, 7075.504714669975, 3974.0129935032483, 4232.470941132358, 4505.324201369821, 4540.523245059221, 4561.817527298871, 4605.088888111463, 4621.69958952667, 4626.768661566908, 4633.328167415773, 4644.698094623838, 4752.643551733634, 5148.871278218075, 5412.050432514289, 5435.42927992563, 5541.196526503634, 5333.0, 6477.935220647827, 6678.7662431815625, 6711.429528490133, 6743.2919543448215, 1563.5934656989264, 1582.2168026826794, 1583.6753465539766, 1583.8495342942401, 1585.9603509912113, 913.5295322908707, 982.7960748083541, 1149.9540018399337, 1195.3784032303154, 1227.4415141110774, 5253.921191182136, 6301.802657495061, 6344.873102537924, 6373.776917807947, 6381.457576106083, 5499.917501237484, 6387.872242555216, 6877.862442751217, 6901.0, 6949.722011119498, 5643.379228284885, 6160.476359509402, 6252.874942501216, 6446.452051575575, 6447.838804029937, 3197.904062878117, 3278.1804548862783, 3611.7674681160215, 3615.94576081359, 3631.891043268706, 6869.862602747917, 7191.64041797908, 7220.4584656151, 7248.043028382307, 7253.419726421874, 7080.398166155832, 7171.063812770522, 7178.4616153788675, 7213.783586492414, 7216.386607138347, 6341.746330146742, 6447.548671593037, 6604.768833090915, 6677.632730199788, 6729.360710732375, 6231.781887633911, 6433.613983161025, 6951.652417379009, 6957.79126626202, 6974.407175390149, 6595.703193356215, 6795.966020169867, 6875.89686154698, 6879.8968015480805, 6906.620135892374, 6350.76160148785, 7040.260772618802, 7090.822729431806, 7108.46686498525, 7315.48791584584, 4560.4983451820935, 4561.931571026371, 4570.314452831969, 4572.993941332901, 4589.0363023765385, 6424.967875160594, 6571.245929802688, 6888.690008949709, 6942.687579059056, 6984.615846128511, 6049.576529642883, 6066.787662431793, 6723.932760672331, 6729.831754206184, 6734.797956061326, 4899.485554016777, 6266.777978294189, 6322.146510221061, 6610.206775186816, 6652.310121364523, 5449.6730196188355, 6252.874942501216, 6463.0, 6530.183727034121, 6542.83642908912, 5478.137433272547, 6009.759609615741, 6595.845726997661, 6696.397324240646, 6743.831404214934, 6090.482309003607, 6361.681915904279, 6440.32376600469, 6446.64543450096, 6484.610923344614], "value": 4861.178091183553, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [822.8683410654296, 838.3209600223819, 838.9370797190211, 861.3841103610919, 862.8101817600126, 16105.35578576857, 16231.26959286832, 16471.258793354296, 17971.820281797212, 18634.906825465852, 17563.64872702545, 17644.82355176448, 17811.732824007617, 17929.372471963485, 18177.818441801275, 954.5084281594984, 967.1875624475439, 968.1722127580922, 968.6416026070364, 970.4904924914441, 970.9223262139012, 975.1126474907835, 978.0757184460688, 979.2704435195789, 984.9753756156117, 1033.829418146005, 1034.7826956339177, 1040.0743338428804, 1040.1834559870504, 1040.8282633365523, 1015.0103648942296, 1030.2427715629044, 1030.6753372687617, 1031.6028329093278, 1036.0364860679565, 650.1418128070949, 724.0623392706458, 734.9963250183715, 754.7660225330166, 761.9847603047964, 16191.91904040484, 16245.268962896698, 16353.672926541403, 16426.42507512231, 16510.75233871493, 16100.516984490485, 16587.0, 16738.079405632685, 16898.15509224534, 16946.406875759414, 11412.600558980479, 13871.237081960488, 13948.93025534876, 13993.650158746012, 14005.719885602333, 3397.3884700753856, 3507.386207413718, 3525.876594319212, 3535.1515636247113, 3547.9290414191573, 102538.97461025369, 110074.44962775215, 117256.99999999914, 117584.0, 119411.40294298473, 13019.283939383235, 13311.267880266678, 13350.866491335157, 13352.265625390502, 13357.666058348424, 24335.14826981047, 25099.121530746335, 25197.87401062983, 25495.617565736156, 25604.615930761054, 7814.6874125034365, 7915.287624113857, 7921.247481489249, 7924.841503169904, 7925.841483170304, 3914.080191155076, 3971.5631280559114, 4000.179963107556, 4010.9598904010586, 4016.8393264269685, 4092.4653255029366, 4278.2085314216965, 4278.572142785759, 4332.653387728974, 4343.652507799368, 844.0405099865012, 890.9086369197681, 946.8911075226437, 948.4404201521136, 953.0421925964362, 618.1346115438332, 623.8814625221194, 654.2476152424749, 656.9113169722121, 674.0024763350171, 10902.945485272523, 11009.119270458345, 11659.300441973339, 11895.940520297516, 11944.402779860971, 605.4702135631322, 620.7516993202755, 632.1434456311723, 646.5054233511273, 660.4452260101538, 5329.040772660958, 5334.91997620036, 5581.49766521015, 5650.095984642519, 5711.171880077365, 105329.47335263275, 107677.461612693, 107875.46062269638, 109716.0, 110006.44996775125, 68799.65600171968, 89385.10614893898, 91340.54329728441, 91901.0, 93574.0, 84424.0, 86278.0, 86501.0, 87019.0, 87326.0, 10127.64553240633, 10503.527341269813, 11238.719032024264, 11434.0, 11496.195266331277, 41436.37845432261, 41545.3381864722, 41962.53131140395, 42004.57995420007, 42241.94395140146, 53977.0, 54625.72687136698, 54874.72562637161, 55020.24493876531, 55402.72298638481, 13577.389017494039, 14113.576592702235, 16959.0, 16989.235484402983, 17017.48947531576, 18203.45389638313, 18316.0, 18384.356547520772, 19008.0, 19059.237630494627, 16994.0, 17395.82604173942, 17534.210960507062, 17629.20668569892, 17693.734593980844, 16455.588610284838, 17507.0, 17946.0, 18254.72617910759, 18309.267629295213, 16030.599235019217, 16293.429729959395, 16591.91704041472, 16656.833431665527, 16695.49913502597, 10643.467826608794, 10659.733506662396, 10851.565937362417, 11632.418379081182, 12336.013118950643, 13692.452301907811, 13879.861201388261, 14029.438822446988, 14057.929710351791, 14061.648458788612], "value": 8330.229044995795, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1553.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 114.0, 116.0, 115.0, 114.0, 115.0, 115.0, 115.0, 114.0, 115.0], "value": 114.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 115.0, 122.0, 149.0, 99.0, 106.0, 143.0, 149.0, 163.0, 115.0], "value": 130.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 203.0, 196.0, 207.0, 214.0, 288.0, 209.0, 285.0, 259.0, 198.0], "value": 225.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 58.0, 65.0, 100.0, 91.0, 85.0, 58.0, 63.0, 78.0, 59.0], "value": 74.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 70.0, 83.0, 72.0, 73.0, 71.0, 90.0, 68.0, 88.0, 94.0], "value": 79.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 90.0, 96.0, 90.0, 90.0, 90.0, 89.0, 91.0, 91.0, 89.0], "value": 90.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 115.0, 98.0, 98.0, 109.0, 97.0, 105.0, 93.0, 148.0, 156.0], "value": 112.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 89.0, 91.0, 96.0, 126.0, 77.0, 142.0, 151.0, 136.0], "value": 109.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 50.0, 51.0, 53.0, 52.0, 52.0, 53.0, 53.0, 52.0, 52.0], "value": 52.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 66.0, 60.0, 57.0, 69.0, 64.0, 58.0, 58.0, 56.0, 59.0], "value": 60.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 83.0, 73.0, 94.0, 107.0, 114.0, 108.0, 83.0, 85.0], "value": 91.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 138.0, 141.0, 136.0, 140.0, 144.0, 204.0, 153.0], "value": 149.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 187.0, 184.0, 185.0, 232.0, 232.0, 190.0, 186.0, 189.0, 183.0], "value": 195.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 69.0, 69.0, 69.0, 70.0, 68.0, 69.0, 68.0, 68.0], "value": 68.7, "unit": "score"}]}]} 10:37:19 INFO - Return code: 0 10:37:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:37:19 ERROR - # TBPL SUCCESS # 10:37:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:37:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:37:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:37:19 INFO - 2017-04-21 10:37:19.654 screenresolution[1651:10672] starting screenresolution argv=screenresolution get 10:37:19 INFO - 2017-04-21 10:37:19.657 screenresolution[1651:10672] Display 0: 1600x1200x32@60 10:37:19 INFO - 2017-04-21 10:37:19.663 screenresolution[1652:10675] starting screenresolution argv=screenresolution list 10:37:19 INFO - Available Modes on Display 0 10:37:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:37:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:37:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:37:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:37:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:37:19 INFO - Intel Iris: 10:37:19 INFO - Chipset Model: Intel Iris 10:37:19 INFO - Type: GPU 10:37:19 INFO - Bus: Built-In 10:37:19 INFO - VRAM (Dynamic, Max): 1536 MB 10:37:19 INFO - Vendor: Intel (0x8086) 10:37:19 INFO - Device ID: 0x0a2e 10:37:19 INFO - Revision ID: 0x0009 10:37:19 INFO - Displays: 10:37:19 INFO - Display: 10:37:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:37:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:37:19 INFO - Display Serial Number: 1600x1200 60 10:37:19 INFO - Main Display: Yes 10:37:19 INFO - Mirror: Off 10:37:19 INFO - Online: Yes 10:37:19 INFO - Rotation: Supported 10:37:19 INFO - Return code: 0 10:37:19 INFO - Running post-action listener: _resource_record_post_action 10:37:19 INFO - [mozharness: 2017-04-21 17:37:19.897083Z] Finished run-tests step (success) 10:37:19 INFO - Running post-run listener: _resource_record_post_run 10:37:19 INFO - Total resource usage - Wall time: 1198s; CPU: 54.0%; Read bytes: 40397312; Write bytes: 520134656; Read time: 396; Write time: 1719 10:37:19 INFO - TinderboxPrint: CPU usage
54.0% 10:37:19 INFO - TinderboxPrint: I/O read bytes / time
40,397,312 / 396 10:37:19 INFO - TinderboxPrint: I/O write bytes / time
520,134,656 / 1,719 10:37:19 INFO - TinderboxPrint: CPU idle
2,206.4 (46.0%) 10:37:19 INFO - TinderboxPrint: CPU system
962.5 (20.1%) 10:37:19 INFO - TinderboxPrint: CPU user
1,624.7 (33.9%) 10:37:19 INFO - TinderboxPrint: Swap in / out
248,270,848 / 0 10:37:19 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 207665664; Write bytes: 204519424; Read time: 15976; Write time: 382 10:37:19 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 35498496; Write bytes: 308434944; Read time: 358; Write time: 1306 10:37:20 INFO - Running post-run listener: _upload_blobber_files 10:37:20 INFO - Blob upload gear active. 10:37:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:37:20 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:37:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:37:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:37:20 INFO - (blobuploader) - INFO - Open directory for files ... 10:37:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:37:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:37:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:37:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:37:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:37:21 INFO - (blobuploader) - INFO - Done attempting. 10:37:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:37:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:37:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:37:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:37:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:37:22 INFO - (blobuploader) - INFO - Done attempting. 10:37:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:37:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:37:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:37:23 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:37:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:37:23 INFO - (blobuploader) - INFO - Done attempting. 10:37:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:37:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:37:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:37:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:37:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:37:25 INFO - (blobuploader) - INFO - Done attempting. 10:37:25 INFO - (blobuploader) - INFO - Iteration through files over. 10:37:25 INFO - Return code: 0 10:37:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:37:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:37:25 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f6372e092f044ef6c2feb0101010d24672a187e883ca402fc3897c4b15dedfabfe34936faa9d6f5ac923b0c58355125aa10c07aa299b16557196c8de29936c3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f67fb8262a618a7d7d0473c61f49f93eb21d8099fd01fbc4bb60323dc0f4394186c6c8e9ab251de39f9baf0e215598570ec1b3b8ff7b69115cb85aadb3d8538", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1878c5e3ec0dbd1364698512d695842d0939e6264890e5dc33e73287b6739c7acddf5cd624eae21d9f9db1111ea7f17deecdbee6ab957dac15cc899997ac83e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d132684449e131f3d7e67ed0f61b8aa7615cdf5eba56378b3591c476cb6d79fe26c251ce52da44c0eb22459608ce99460f08bb7373696ff7d84719985f809936"} 10:37:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:37:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:37:25 INFO - Contents: 10:37:25 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f6372e092f044ef6c2feb0101010d24672a187e883ca402fc3897c4b15dedfabfe34936faa9d6f5ac923b0c58355125aa10c07aa299b16557196c8de29936c3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f67fb8262a618a7d7d0473c61f49f93eb21d8099fd01fbc4bb60323dc0f4394186c6c8e9ab251de39f9baf0e215598570ec1b3b8ff7b69115cb85aadb3d8538", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1878c5e3ec0dbd1364698512d695842d0939e6264890e5dc33e73287b6739c7acddf5cd624eae21d9f9db1111ea7f17deecdbee6ab957dac15cc899997ac83e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d132684449e131f3d7e67ed0f61b8aa7615cdf5eba56378b3591c476cb6d79fe26c251ce52da44c0eb22459608ce99460f08bb7373696ff7d84719985f809936"} 10:37:25 INFO - Running post-run listener: copy_logs_to_upload_dir 10:37:25 INFO - Copying logs to upload dir... 10:37:25 INFO - mkdir: /builds/slave/test/build/upload/logs 10:37:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1282.032078 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-04-21 10:37:25.986224) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-21 10:37:25.990271) ========= 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.ZF1eju7fy4/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.FVwaqIVpfh/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f6372e092f044ef6c2feb0101010d24672a187e883ca402fc3897c4b15dedfabfe34936faa9d6f5ac923b0c58355125aa10c07aa299b16557196c8de29936c3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f67fb8262a618a7d7d0473c61f49f93eb21d8099fd01fbc4bb60323dc0f4394186c6c8e9ab251de39f9baf0e215598570ec1b3b8ff7b69115cb85aadb3d8538", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1878c5e3ec0dbd1364698512d695842d0939e6264890e5dc33e73287b6739c7acddf5cd624eae21d9f9db1111ea7f17deecdbee6ab957dac15cc899997ac83e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d132684449e131f3d7e67ed0f61b8aa7615cdf5eba56378b3591c476cb6d79fe26c251ce52da44c0eb22459608ce99460f08bb7373696ff7d84719985f809936"} build_url:https://queue.taskcluster.net/v1/task/A8mF30RvQR6XfNnStBRG4g/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011260 build_url: 'https://queue.taskcluster.net/v1/task/A8mF30RvQR6XfNnStBRG4g/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f6372e092f044ef6c2feb0101010d24672a187e883ca402fc3897c4b15dedfabfe34936faa9d6f5ac923b0c58355125aa10c07aa299b16557196c8de29936c3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f67fb8262a618a7d7d0473c61f49f93eb21d8099fd01fbc4bb60323dc0f4394186c6c8e9ab251de39f9baf0e215598570ec1b3b8ff7b69115cb85aadb3d8538", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1878c5e3ec0dbd1364698512d695842d0939e6264890e5dc33e73287b6739c7acddf5cd624eae21d9f9db1111ea7f17deecdbee6ab957dac15cc899997ac83e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d132684449e131f3d7e67ed0f61b8aa7615cdf5eba56378b3591c476cb6d79fe26c251ce52da44c0eb22459608ce99460f08bb7373696ff7d84719985f809936"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-21 10:37:26.025382) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 10:37:26.025706) ========= 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.ZF1eju7fy4/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.FVwaqIVpfh/Listeners TMPDIR=/var/folders/_6/_bx65ff90k958brrpkt4nbpw00000w/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.005266 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-21 10:37:26.074857) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-21 10:37:26.075167) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-21 10:37:26.075518) ========= ========= Total master_lag: 0.18 =========