builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0018 starttime: 1491651180.07 results: success (0) buildid: 20170408030204 builduid: 45b76d9c61284338b30d3d52a162e7ff revision: 35c7be9c2db288d1d449e3cc586c4164d642c5fd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-08 04:33:00.067270) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-08 04:33:00.071045) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-08 04:33:00.071362) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-08 04:33:00.161225) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-08 04:33:00.161620) ========= 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.81WDS52tjK/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.i5NQQUdRFJ/Listeners TMPDIR=/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/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-08 04:33:00-- 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% 10.1M=0.001s 2017-04-08 04:33:00 (10.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.652971 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-08 04:33:00.838701) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-08 04:33:00.839017) ========= 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.81WDS52tjK/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.i5NQQUdRFJ/Listeners TMPDIR=/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/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.023551 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-08 04:33:00.889132) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-08 04:33:00.889545) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 35c7be9c2db288d1d449e3cc586c4164d642c5fd --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 35c7be9c2db288d1d449e3cc586c4164d642c5fd --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.81WDS52tjK/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.i5NQQUdRFJ/Listeners TMPDIR=/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/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-08 04:33:00,977 truncating revision to first 12 chars 2017-04-08 04:33:00,977 Setting DEBUG logging. 2017-04-08 04:33:00,977 attempt 1/10 2017-04-08 04:33:00,977 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/35c7be9c2db2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-08 04:33:01,719 unpacking tar archive at: mozilla-central-35c7be9c2db2/testing/mozharness/ program finished with exit code 0 elapsedTime=1.016390 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-08 04:33:01.931231) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-08 04:33:01.932019) ========= script_repo_revision: 35c7be9c2db288d1d449e3cc586c4164d642c5fd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-08 04:33:01.932851) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-08 04:33:01.933424) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-08 04:33:01.954961) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 32 secs) (at 2017-04-08 04:33:01.955401) ========= /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.81WDS52tjK/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.i5NQQUdRFJ/Listeners TMPDIR=/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/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 04:33:02 INFO - MultiFileLogger online at 20170408 04:33:02 in /builds/slave/test 04:33:02 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 04:33:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:33:02 INFO - {'append_to_log': False, 04:33:02 INFO - 'base_work_dir': '/builds/slave/test', 04:33:02 INFO - 'blob_upload_branch': 'Firefox', 04:33:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:33:02 INFO - 'branch': 'Firefox', 04:33:02 INFO - 'buildbot_json_path': 'buildprops.json', 04:33:02 INFO - 'config_files': ('talos/mac_config.py',), 04:33:02 INFO - 'default_actions': ('clobber', 04:33:02 INFO - 'read-buildbot-config', 04:33:02 INFO - 'download-and-extract', 04:33:02 INFO - 'populate-webroot', 04:33:02 INFO - 'create-virtualenv', 04:33:02 INFO - 'install', 04:33:02 INFO - 'run-tests'), 04:33:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:33:02 INFO - 'download_minidump_stackwalk': True, 04:33:02 INFO - 'download_symbols': 'ondemand', 04:33:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:33:02 INFO - 'tooltool.py': '/tools/tooltool.py', 04:33:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:33:02 INFO - '/tools/misc-python/virtualenv.py')}, 04:33:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:33:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:33:02 INFO - 'gecko_profile': False, 04:33:02 INFO - 'gecko_profile_interval': 0, 04:33:02 INFO - 'installer_path': 'installer.exe', 04:33:02 INFO - 'log_level': 'info', 04:33:02 INFO - 'log_name': 'talos', 04:33:02 INFO - 'log_to_console': True, 04:33:02 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:33:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:33:02 INFO - 'opt_config_files': (), 04:33:02 INFO - 'pip_index': False, 04:33:02 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:33:02 INFO - 'cmd': ('bash', 04:33:02 INFO - '-c', 04:33:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:33:02 INFO - 'enabled': True, 04:33:02 INFO - 'halt_on_failure': False, 04:33:02 INFO - 'name': 'check_screen_resolution'},), 04:33:02 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:33:02 INFO - 'cmd': ('bash', 04:33:02 INFO - '-c', 04:33:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:33:02 INFO - 'enabled': True, 04:33:02 INFO - 'halt_on_failure': False, 04:33:02 INFO - 'name': 'check_screen_resolution'},), 04:33:02 INFO - 'run_cmd_checks_enabled': True, 04:33:02 INFO - 'suite': 'dromaeojs-e10s', 04:33:02 INFO - 'system_bits': '32', 04:33:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:33:02 INFO - 'title': 't-yosemite-r7-0018', 04:33:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:33:02 INFO - 'use_talos_json': True, 04:33:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:33:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:33:02 INFO - 'work_dir': 'build'} 04:33:02 INFO - [mozharness: 2017-04-08 11:33:02.164391Z] Running clobber step. 04:33:02 INFO - Running pre-action listener: _resource_record_pre_action 04:33:02 INFO - Running main action method: clobber 04:33:02 INFO - rmtree: /builds/slave/test/build 04:33:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:33:04 INFO - Running post-action listener: _resource_record_post_action 04:33:04 INFO - [mozharness: 2017-04-08 11:33:04.252909Z] Finished clobber step (success) 04:33:04 INFO - [mozharness: 2017-04-08 11:33:04.253053Z] Running read-buildbot-config step. 04:33:04 INFO - Running pre-action listener: _resource_record_pre_action 04:33:04 INFO - Running main action method: read_buildbot_config 04:33:04 INFO - Using buildbot properties: 04:33:04 INFO - { 04:33:04 INFO - "project": "", 04:33:04 INFO - "product": "firefox", 04:33:04 INFO - "script_repo_revision": "production", 04:33:04 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 04:33:04 INFO - "repository": "", 04:33:04 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 04:33:04 INFO - "buildid": "20170408030204", 04:33:04 INFO - "stage_platform": "macosx64", 04:33:04 INFO - "basedir": "/builds/slave/test", 04:33:04 INFO - "nightly_build": "True", 04:33:04 INFO - "buildnumber": 190, 04:33:04 INFO - "slavename": "t-yosemite-r7-0018", 04:33:04 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 04:33:04 INFO - "platform": "yosemite_r7", 04:33:04 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:33:04 INFO - "branch": "mozilla-central", 04:33:04 INFO - "repo_path": "mozilla-central", 04:33:04 INFO - "revision": "35c7be9c2db288d1d449e3cc586c4164d642c5fd", 04:33:04 INFO - "pgo_build": "False", 04:33:04 INFO - "builduid": "45b76d9c61284338b30d3d52a162e7ff", 04:33:04 INFO - "slavebuilddir": "test" 04:33:04 INFO - } 04:33:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/ExvM5Va5Sw28xw6LSai0rw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 04:33:04 INFO - Running post-action listener: _resource_record_post_action 04:33:04 INFO - [mozharness: 2017-04-08 11:33:04.256562Z] Finished read-buildbot-config step (success) 04:33:04 INFO - [mozharness: 2017-04-08 11:33:04.256713Z] Running download-and-extract step. 04:33:04 INFO - Running pre-action listener: _resource_record_pre_action 04:33:04 INFO - Running main action method: download_and_extract 04:33:04 INFO - mkdir: /builds/slave/test/build/tests 04:33:04 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')]} 04:33:04 INFO - trying https://queue.taskcluster.net/v1/task/ExvM5Va5Sw28xw6LSai0rw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 04:33:04 INFO - Downloading https://queue.taskcluster.net/v1/task/ExvM5Va5Sw28xw6LSai0rw/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 04:33:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ExvM5Va5Sw28xw6LSai0rw/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 04:33:05 INFO - Downloaded 1325 bytes. 04:33:05 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:33:05 INFO - Using the following test package requirements: 04:33:05 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:33:05 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 04:33:05 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:33:05 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:33:05 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 04:33:05 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:33:05 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 04:33:05 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:33:05 INFO - u'jsshell-mac.zip'], 04:33:05 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:33:05 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 04:33:05 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:33:05 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:33:05 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 04:33:05 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:33:05 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 04:33:05 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:33:05 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 04:33:05 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:33:05 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 04:33:05 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:33:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ExvM5Va5Sw28xw6LSai0rw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:33:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ExvM5Va5Sw28xw6LSai0rw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:33:05 INFO - Fetch https://queue.taskcluster.net/v1/task/ExvM5Va5Sw28xw6LSai0rw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:33:07 INFO - Expected file size: 52521421 04:33:07 INFO - Obtained file size: 52521421 04:33:23 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 04:33:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ExvM5Va5Sw28xw6LSai0rw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:33:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ExvM5Va5Sw28xw6LSai0rw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:33:23 INFO - Fetch https://queue.taskcluster.net/v1/task/ExvM5Va5Sw28xw6LSai0rw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:33:25 INFO - Expected file size: 52521421 04:33:25 INFO - Obtained file size: 52521421 04:33:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ExvM5Va5Sw28xw6LSai0rw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 04:33:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ExvM5Va5Sw28xw6LSai0rw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:33:41 INFO - Fetch https://queue.taskcluster.net/v1/task/ExvM5Va5Sw28xw6LSai0rw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 04:33:42 INFO - Expected file size: 14404138 04:33:42 INFO - Obtained file size: 14404138 04:33:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:42 INFO - trying https://queue.taskcluster.net/v1/task/ExvM5Va5Sw28xw6LSai0rw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:33:42 INFO - Downloading https://queue.taskcluster.net/v1/task/ExvM5Va5Sw28xw6LSai0rw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 04:33:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ExvM5Va5Sw28xw6LSai0rw/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 04:33:44 INFO - Downloaded 71001370 bytes. 04:33:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ExvM5Va5Sw28xw6LSai0rw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:33:44 INFO - mkdir: /builds/slave/test/properties 04:33:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:33:44 INFO - Writing to file /builds/slave/test/properties/build_url 04:33:44 INFO - Contents: 04:33:44 INFO - build_url:https://queue.taskcluster.net/v1/task/ExvM5Va5Sw28xw6LSai0rw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:33:45 INFO - Running post-action listener: _resource_record_post_action 04:33:45 INFO - Running post-action listener: set_extra_try_arguments 04:33:45 INFO - [mozharness: 2017-04-08 11:33:45.250168Z] Finished download-and-extract step (success) 04:33:45 INFO - [mozharness: 2017-04-08 11:33:45.250318Z] Running populate-webroot step. 04:33:45 INFO - Running pre-action listener: _resource_record_pre_action 04:33:45 INFO - Running main action method: populate_webroot 04:33:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:33:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:33:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:33:45 INFO - '--tppagecycles', 04:33:45 INFO - '7'], 04:33:45 INFO - 'tests': ['tsvgm']}}, 04:33:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:33:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:33:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:33:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:33:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:33:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:33:45 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:33:45 INFO - 'talos_options': ['--disable-e10s'], 04:33:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:33:45 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:33:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:33:45 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:33:45 INFO - 'talos_options': ['--disable-e10s'], 04:33:45 INFO - 'tests': ['damp', 'tps']}, 04:33:45 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:33:45 INFO - 'tests': ['damp', 'tps']}, 04:33:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:33:45 INFO - 'tests': ['dromaeo_dom']}, 04:33:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:33:45 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:33:45 INFO - 'tests': ['basic_compositor_video']}, 04:33:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:33:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:33:45 INFO - 'tests': ['a11yr', 04:33:45 INFO - 'ts_paint', 04:33:45 INFO - 'tpaint', 04:33:45 INFO - 'sessionrestore', 04:33:45 INFO - 'sessionrestore_no_auto_restore', 04:33:45 INFO - 'tabpaint']}, 04:33:45 INFO - 'other-e10s': {'tests': ['a11yr', 04:33:45 INFO - 'ts_paint', 04:33:45 INFO - 'tpaint', 04:33:45 INFO - 'sessionrestore', 04:33:45 INFO - 'sessionrestore_no_auto_restore', 04:33:45 INFO - 'tabpaint']}, 04:33:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:33:45 INFO - 'ts_paint', 04:33:45 INFO - 'tpaint', 04:33:45 INFO - 'sessionrestore', 04:33:45 INFO - 'sessionrestore_no_auto_restore', 04:33:45 INFO - 'tabpaint']}, 04:33:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:33:45 INFO - 'ts_paint', 04:33:45 INFO - 'tpaint', 04:33:45 INFO - 'sessionrestore', 04:33:45 INFO - 'sessionrestore_no_auto_restore', 04:33:45 INFO - 'tabpaint']}, 04:33:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:33:45 INFO - 'tests': ['a11yr', 04:33:45 INFO - 'ts_paint', 04:33:45 INFO - 'tpaint', 04:33:45 INFO - 'sessionrestore', 04:33:45 INFO - 'sessionrestore_no_auto_restore', 04:33:45 INFO - 'tabpaint']}, 04:33:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:33:45 INFO - 'tests': ['a11yr', 04:33:45 INFO - 'ts_paint', 04:33:45 INFO - 'tpaint', 04:33:45 INFO - 'sessionrestore', 04:33:45 INFO - 'sessionrestore_no_auto_restore', 04:33:45 INFO - 'tabpaint']}, 04:33:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:33:45 INFO - 'tests': ['tsvgx', 04:33:45 INFO - 'tsvgr_opacity', 04:33:45 INFO - 'tart', 04:33:45 INFO - 'tscrollx', 04:33:45 INFO - 'cart', 04:33:45 INFO - 'tsvg_static']}, 04:33:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:33:45 INFO - 'tsvgr_opacity', 04:33:45 INFO - 'tart', 04:33:45 INFO - 'tscrollx', 04:33:45 INFO - 'cart', 04:33:45 INFO - 'tsvg_static']}, 04:33:45 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:33:45 INFO - 'talos_options': ['--disable-e10s'], 04:33:45 INFO - 'tests': ['tp5o']}, 04:33:45 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:33:45 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:33:45 INFO - 'talos_options': ['--disable-e10s', 04:33:45 INFO - '--xperf_path', 04:33:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:33:45 INFO - 'tests': ['tp5n']}, 04:33:45 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:33:45 INFO - 'talos_options': ['--xperf_path', 04:33:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:33:45 INFO - 'tests': ['tp5n']}}, 04:33:45 INFO - 'talos.zip': {'path': '', 04:33:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:33:45 INFO - Running post-action listener: _resource_record_post_action 04:33:45 INFO - [mozharness: 2017-04-08 11:33:45.269303Z] Finished populate-webroot step (success) 04:33:45 INFO - [mozharness: 2017-04-08 11:33:45.269438Z] Running create-virtualenv step. 04:33:45 INFO - Running pre-action listener: _resource_record_pre_action 04:33:45 INFO - Running main action method: create_virtualenv 04:33:45 INFO - Creating virtualenv /builds/slave/test/build/venv 04:33:45 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 04:33:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:33:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:33:45 INFO - Using real prefix '/tools/python27' 04:33:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:33:46 INFO - Installing distribute.............................................................................................................................................................................................done. 04:33:49 INFO - Installing pip.................done. 04:33:49 INFO - Return code: 0 04:33:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:33:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:33:49 INFO - Reading from file tmpfile_stdout 04:33:49 INFO - Output received: 04:33:49 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) 04:33:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:33:49 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')]} 04:33:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:33:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:49 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')]} 04:33:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:33:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:50 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 0x10eb73b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb76768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f984044f940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e951d30>, '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 0x10e878db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e946be8>, '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.81WDS52tjK/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.i5NQQUdRFJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/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 04:33:50 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 04:33:50 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 04:33:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.81WDS52tjK/Render', 04:33:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:33:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:33:50 INFO - 'HOME': '/Users/cltbld', 04:33:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:33:50 INFO - 'LOGNAME': 'cltbld', 04:33:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:50 INFO - 'MOZ_NO_REMOTE': '1', 04:33:50 INFO - 'NO_EM_RESTART': '1', 04:33:50 INFO - 'PAGER': '/bin/cat', 04:33:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:33:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:50 INFO - 'PWD': '/builds/slave/test', 04:33:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:33:50 INFO - 'SHELL': '/bin/bash', 04:33:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i5NQQUdRFJ/Listeners', 04:33:50 INFO - 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/', 04:33:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:33:50 INFO - 'USER': 'cltbld', 04:33:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:33:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:33:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:50 INFO - 'XPC_FLAGS': '0x0', 04:33:50 INFO - 'XPC_SERVICE_NAME': '0', 04:33:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:33:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:33:50 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 04:33:50 INFO - Cleaning up... 04:33:50 INFO - Return code: 0 04:33:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:33:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:33:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:33:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:50 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 0x10eb73b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb76768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f984044f940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e951d30>, '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 0x10e878db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e946be8>, '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.81WDS52tjK/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.i5NQQUdRFJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/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 04:33:50 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 04:33:50 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 04:33:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.81WDS52tjK/Render', 04:33:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:33:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:33:50 INFO - 'HOME': '/Users/cltbld', 04:33:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:33:50 INFO - 'LOGNAME': 'cltbld', 04:33:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:50 INFO - 'MOZ_NO_REMOTE': '1', 04:33:50 INFO - 'NO_EM_RESTART': '1', 04:33:50 INFO - 'PAGER': '/bin/cat', 04:33:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:33:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:50 INFO - 'PWD': '/builds/slave/test', 04:33:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:33:50 INFO - 'SHELL': '/bin/bash', 04:33:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i5NQQUdRFJ/Listeners', 04:33:50 INFO - 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/', 04:33:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:33:50 INFO - 'USER': 'cltbld', 04:33:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:33:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:33:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:50 INFO - 'XPC_FLAGS': '0x0', 04:33:50 INFO - 'XPC_SERVICE_NAME': '0', 04:33:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:33:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:33:50 INFO - Downloading/unpacking psutil>=3.1.1 04:33:50 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 04:33:50 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 04:33:50 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 04:33:50 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 04:33:50 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 04:33:50 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 04:33:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:33:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:33:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:33:55 INFO - Installing collected packages: psutil 04:33:55 INFO - Running setup.py install for psutil 04:33:55 INFO - building 'psutil._psutil_osx' extension 04:33: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 04:33: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_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:33: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/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:33:55 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 04:33:55 INFO - building 'psutil._psutil_posix' extension 04:33:55 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 04:33:56 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:33:56 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:33:56 INFO - ^ 04:33:56 INFO - 1 warning generated. 04:33: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 04:33:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:33:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:33:56 INFO - Successfully installed psutil 04:33:56 INFO - Cleaning up... 04:33:56 INFO - Return code: 0 04:33:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:33:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:33:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:33:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10eb73b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb76768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f984044f940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e951d30>, '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 0x10e878db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e946be8>, '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.81WDS52tjK/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.i5NQQUdRFJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/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 04:33:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:33:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:33:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.81WDS52tjK/Render', 04:33:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:33:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:33:56 INFO - 'HOME': '/Users/cltbld', 04:33:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:33:56 INFO - 'LOGNAME': 'cltbld', 04:33:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:56 INFO - 'MOZ_NO_REMOTE': '1', 04:33:56 INFO - 'NO_EM_RESTART': '1', 04:33:56 INFO - 'PAGER': '/bin/cat', 04:33:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:33:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:56 INFO - 'PWD': '/builds/slave/test', 04:33:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:33:56 INFO - 'SHELL': '/bin/bash', 04:33:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i5NQQUdRFJ/Listeners', 04:33:56 INFO - 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/', 04:33:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:33:56 INFO - 'USER': 'cltbld', 04:33:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:33:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:33:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:56 INFO - 'XPC_FLAGS': '0x0', 04:33:56 INFO - 'XPC_SERVICE_NAME': '0', 04:33:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:33:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:33:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:33:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:33:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:33:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:33:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:33:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:33:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:33:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:33:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:33:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:33:59 INFO - Installing collected packages: mozsystemmonitor 04:33:59 INFO - Running setup.py install for mozsystemmonitor 04:34:00 INFO - Successfully installed mozsystemmonitor 04:34:00 INFO - Cleaning up... 04:34:00 INFO - Return code: 0 04:34:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:34:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:00 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 0x10eb73b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb76768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f984044f940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e951d30>, '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 0x10e878db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e946be8>, '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.81WDS52tjK/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.i5NQQUdRFJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/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 04:34:00 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 04:34:00 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 04:34:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.81WDS52tjK/Render', 04:34:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:34:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:34:00 INFO - 'HOME': '/Users/cltbld', 04:34:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:34:00 INFO - 'LOGNAME': 'cltbld', 04:34:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:00 INFO - 'MOZ_NO_REMOTE': '1', 04:34:00 INFO - 'NO_EM_RESTART': '1', 04:34:00 INFO - 'PAGER': '/bin/cat', 04:34:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:34:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:00 INFO - 'PWD': '/builds/slave/test', 04:34:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:34:00 INFO - 'SHELL': '/bin/bash', 04:34:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i5NQQUdRFJ/Listeners', 04:34:00 INFO - 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/', 04:34:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:34:00 INFO - 'USER': 'cltbld', 04:34:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:34:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:34:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:00 INFO - 'XPC_FLAGS': '0x0', 04:34:00 INFO - 'XPC_SERVICE_NAME': '0', 04:34:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:34:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:00 INFO - Downloading/unpacking jsonschema==2.5.1 04:34:00 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 04:34:00 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 04:34:00 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 04:34:00 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 04:34:00 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 04:34:00 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 04:34:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:34:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:34:06 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 04:34:06 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 04:34:06 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 04:34:06 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 04:34:06 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 04:34:06 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 04:34:06 INFO - Downloading functools32-3.2.3-2.tar.gz 04:34:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:34:06 INFO - warning: no files found matching '*.txt' 04:34:06 INFO - no previously-included directories found matching 'build' 04:34:06 INFO - no previously-included directories found matching 'dist' 04:34:06 INFO - no previously-included directories found matching '.git*' 04:34:06 INFO - Installing collected packages: jsonschema, functools32 04:34:06 INFO - Running setup.py install for functools32 04:34:06 INFO - warning: no files found matching '*.txt' 04:34:06 INFO - no previously-included directories found matching 'build' 04:34:06 INFO - no previously-included directories found matching 'dist' 04:34:06 INFO - no previously-included directories found matching '.git*' 04:34:07 INFO - Successfully installed jsonschema functools32 04:34:07 INFO - Cleaning up... 04:34:07 INFO - Return code: 0 04:34:07 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:34:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10eb73b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb76768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f984044f940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e951d30>, '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 0x10e878db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e946be8>, '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.81WDS52tjK/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.i5NQQUdRFJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/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 04:34:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:34:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:34:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.81WDS52tjK/Render', 04:34:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:34:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:34:07 INFO - 'HOME': '/Users/cltbld', 04:34:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:34:07 INFO - 'LOGNAME': 'cltbld', 04:34:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:07 INFO - 'MOZ_NO_REMOTE': '1', 04:34:07 INFO - 'NO_EM_RESTART': '1', 04:34:07 INFO - 'PAGER': '/bin/cat', 04:34:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:34:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:07 INFO - 'PWD': '/builds/slave/test', 04:34:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:34:07 INFO - 'SHELL': '/bin/bash', 04:34:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i5NQQUdRFJ/Listeners', 04:34:07 INFO - 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/', 04:34:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:34:07 INFO - 'USER': 'cltbld', 04:34:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:34:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:34:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:07 INFO - 'XPC_FLAGS': '0x0', 04:34:07 INFO - 'XPC_SERVICE_NAME': '0', 04:34:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:34:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:07 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:34:07 INFO - Cleaning up... 04:34:07 INFO - Return code: 0 04:34:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:34:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10eb73b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb76768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f984044f940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e951d30>, '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 0x10e878db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e946be8>, '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.81WDS52tjK/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.i5NQQUdRFJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/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 04:34:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:34:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:34:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.81WDS52tjK/Render', 04:34:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:34:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:34:07 INFO - 'HOME': '/Users/cltbld', 04:34:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:34:07 INFO - 'LOGNAME': 'cltbld', 04:34:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:07 INFO - 'MOZ_NO_REMOTE': '1', 04:34:07 INFO - 'NO_EM_RESTART': '1', 04:34:07 INFO - 'PAGER': '/bin/cat', 04:34:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:34:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:07 INFO - 'PWD': '/builds/slave/test', 04:34:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:34:07 INFO - 'SHELL': '/bin/bash', 04:34:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i5NQQUdRFJ/Listeners', 04:34:07 INFO - 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/', 04:34:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:34:07 INFO - 'USER': 'cltbld', 04:34:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:34:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:34:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:07 INFO - 'XPC_FLAGS': '0x0', 04:34:07 INFO - 'XPC_SERVICE_NAME': '0', 04:34:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:34:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:07 INFO - Downloading/unpacking blobuploader==1.2.4 04:34:07 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 04:34:07 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 04:34:07 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 04:34:07 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 04:34:07 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 04:34:07 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 04:34:11 INFO - Downloading blobuploader-1.2.4.tar.gz 04:34:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:34:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:34:11 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 04:34:11 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 04:34:11 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 04:34:11 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 04:34:11 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 04:34:11 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 04:34:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:34:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:34:14 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 04:34:14 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 04:34:14 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 04:34:14 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 04:34:14 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 04:34:14 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 04:34:14 INFO - Downloading docopt-0.6.1.tar.gz 04:34:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:34:14 INFO - Installing collected packages: blobuploader, requests, docopt 04:34:14 INFO - Running setup.py install for blobuploader 04:34:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:34:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:34:14 INFO - Running setup.py install for requests 04:34:15 INFO - Running setup.py install for docopt 04:34:15 INFO - Successfully installed blobuploader requests docopt 04:34:15 INFO - Cleaning up... 04:34:15 INFO - Return code: 0 04:34:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:34: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')]} 04:34:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34: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')]} 04:34:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:15 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 0x10eb73b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb76768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f984044f940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e951d30>, '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 0x10e878db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e946be8>, '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.81WDS52tjK/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.i5NQQUdRFJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/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 04:34:15 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 04:34:15 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 04:34:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.81WDS52tjK/Render', 04:34:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:34:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:34:15 INFO - 'HOME': '/Users/cltbld', 04:34:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:34:15 INFO - 'LOGNAME': 'cltbld', 04:34:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:15 INFO - 'MOZ_NO_REMOTE': '1', 04:34:15 INFO - 'NO_EM_RESTART': '1', 04:34:15 INFO - 'PAGER': '/bin/cat', 04:34:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:34:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:15 INFO - 'PWD': '/builds/slave/test', 04:34:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:34:15 INFO - 'SHELL': '/bin/bash', 04:34:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i5NQQUdRFJ/Listeners', 04:34:15 INFO - 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/', 04:34:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:34:15 INFO - 'USER': 'cltbld', 04:34:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:34:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:34:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:15 INFO - 'XPC_FLAGS': '0x0', 04:34:15 INFO - 'XPC_SERVICE_NAME': '0', 04:34:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:34:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:34:15 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-H1jOoX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:34:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:34:16 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-d0HLYE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:34:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:34:16 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-TMZ54s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:34:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:34:16 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-HsXthE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:34:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:34:16 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-nGGLFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:34:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:34:16 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-GTgqmG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:34:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:34:16 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-7rk80h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:34:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:34:16 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-sVCSDv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:34:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:34:16 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-HdEVwa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:34:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:34:16 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-gsfH1V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:34:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:34:16 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-Z84W9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:34:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:34:17 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-cN_13r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:34:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:34:17 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-m8eI3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:34:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:34:17 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-NNBmWL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:34:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:34:17 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-OyE6ha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:34:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:34:17 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-RrAqU8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:34:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:34:17 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-NhyImq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:34:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:34:17 INFO - Running setup.py install for manifestparser 04:34:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:34:17 INFO - Running setup.py install for mozcrash 04:34:18 INFO - Running setup.py install for mozdebug 04:34:18 INFO - Running setup.py install for mozdevice 04:34:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:34:18 INFO - Running setup.py install for mozfile 04:34:18 INFO - Running setup.py install for mozhttpd 04:34:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:34:18 INFO - Running setup.py install for mozinfo 04:34:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:34:18 INFO - Running setup.py install for mozInstall 04:34:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:34:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:34:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:34:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:34:18 INFO - Running setup.py install for mozleak 04:34:19 INFO - Running setup.py install for mozlog 04:34:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:34:19 INFO - Running setup.py install for moznetwork 04:34:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:34:19 INFO - Running setup.py install for mozprocess 04:34:19 INFO - Running setup.py install for mozprofile 04:34:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:34:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:34:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:34:19 INFO - Running setup.py install for mozrunner 04:34:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:34:19 INFO - Running setup.py install for mozscreenshot 04:34:20 INFO - Running setup.py install for moztest 04:34:20 INFO - Running setup.py install for mozversion 04:34:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:34:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:34:20 INFO - Cleaning up... 04:34:20 INFO - Return code: 0 04:34:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:34: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')]} 04:34:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34: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')]} 04:34:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:20 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 0x10eb73b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb76768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f984044f940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e951d30>, '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 0x10e878db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e946be8>, '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.81WDS52tjK/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.i5NQQUdRFJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/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 04:34:20 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 04:34:20 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 04:34:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.81WDS52tjK/Render', 04:34:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:34:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:34:20 INFO - 'HOME': '/Users/cltbld', 04:34:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:34:20 INFO - 'LOGNAME': 'cltbld', 04:34:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:20 INFO - 'MOZ_NO_REMOTE': '1', 04:34:20 INFO - 'NO_EM_RESTART': '1', 04:34:20 INFO - 'PAGER': '/bin/cat', 04:34:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:34:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:20 INFO - 'PWD': '/builds/slave/test', 04:34:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:34:20 INFO - 'SHELL': '/bin/bash', 04:34:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i5NQQUdRFJ/Listeners', 04:34:20 INFO - 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/', 04:34:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:34:20 INFO - 'USER': 'cltbld', 04:34:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:34:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:34:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:20 INFO - 'XPC_FLAGS': '0x0', 04:34:20 INFO - 'XPC_SERVICE_NAME': '0', 04:34:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:34:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:34:20 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-lEgtx_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:34:20 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)) 04:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:34:20 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-e4sqTK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:34:20 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)) 04:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:34:20 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-VgpoB6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:34:20 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)) 04:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:34:20 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-zoeTZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:34:21 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)) 04:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:34:21 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-cCIVS4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:34:21 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)) 04:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:34:21 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-j7Svf_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:34:21 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)) 04:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:34:21 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-iSa3ZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:34:21 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)) 04:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:34:21 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-UrDeD7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:34:21 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)) 04:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:34:21 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-jIrMlu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:34:21 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)) 04:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:34:21 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-WVt2Ge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:34:21 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)) 04:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:34:21 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-30jqOx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:34:21 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)) 04:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:34:21 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-_St_xn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:34:21 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)) 04:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:34:21 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-BHqMsE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:34:22 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)) 04:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:34:22 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-UwEluW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:34:22 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)) 04:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:34:22 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-PtkwO_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:34:22 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)) 04:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:34:22 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-jA8sH6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:34:22 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)) 04:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:34:22 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-2NE494-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:34:22 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)) 04:34:22 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)) 04:34:22 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)) 04:34:22 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)) 04:34:22 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)) 04:34:22 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)) 04:34:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:34:22 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 04:34:22 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 04:34:22 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 04:34:22 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 04:34:22 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 04:34:22 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 04:34:25 INFO - Downloading blessings-1.6.tar.gz 04:34:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:34:25 INFO - Installing collected packages: blessings 04:34:25 INFO - Running setup.py install for blessings 04:34:25 INFO - Successfully installed blessings 04:34:25 INFO - Cleaning up... 04:34:25 INFO - Return code: 0 04:34:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:34:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:34:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:34:26 INFO - Reading from file tmpfile_stdout 04:34:26 INFO - Current package versions: 04:34:26 INFO - blessings == 1.6 04:34:26 INFO - blobuploader == 1.2.4 04:34:26 INFO - docopt == 0.6.1 04:34:26 INFO - functools32 == 3.2.3-2 04:34:26 INFO - jsonschema == 2.5.1 04:34:26 INFO - manifestparser == 1.1 04:34:26 INFO - mozInstall == 1.12 04:34:26 INFO - mozcrash == 1.0 04:34:26 INFO - mozdebug == 0.1 04:34:26 INFO - mozdevice == 0.50 04:34:26 INFO - mozfile == 1.2 04:34:26 INFO - mozhttpd == 0.7 04:34:26 INFO - mozinfo == 0.9 04:34:26 INFO - mozleak == 0.1 04:34:26 INFO - mozlog == 3.4 04:34:26 INFO - moznetwork == 0.27 04:34:26 INFO - mozprocess == 0.25 04:34:26 INFO - mozprofile == 0.28 04:34:26 INFO - mozrunner == 6.13 04:34:26 INFO - mozscreenshot == 0.1 04:34:26 INFO - mozsystemmonitor == 0.3 04:34:26 INFO - moztest == 0.8 04:34:26 INFO - mozversion == 1.4 04:34:26 INFO - psutil == 3.1.1 04:34:26 INFO - requests == 1.2.3 04:34:26 INFO - wsgiref == 0.1.2 04:34:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:34:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:26 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 0x10eb73b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb76768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f984044f940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e951d30>, '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 0x10e878db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e946be8>, '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.81WDS52tjK/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.i5NQQUdRFJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/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 04:34:26 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 04:34:26 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 04:34:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.81WDS52tjK/Render', 04:34:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:34:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:34:26 INFO - 'HOME': '/Users/cltbld', 04:34:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:34:26 INFO - 'LOGNAME': 'cltbld', 04:34:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:26 INFO - 'MOZ_NO_REMOTE': '1', 04:34:26 INFO - 'NO_EM_RESTART': '1', 04:34:26 INFO - 'PAGER': '/bin/cat', 04:34:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:34:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:26 INFO - 'PWD': '/builds/slave/test', 04:34:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:34:26 INFO - 'SHELL': '/bin/bash', 04:34:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i5NQQUdRFJ/Listeners', 04:34:26 INFO - 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/', 04:34:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:34:26 INFO - 'USER': 'cltbld', 04:34:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:34:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:34:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:26 INFO - 'XPC_FLAGS': '0x0', 04:34:26 INFO - 'XPC_SERVICE_NAME': '0', 04:34:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:34:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:26 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)) 04:34:26 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)) 04:34:26 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)) 04:34:26 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)) 04:34:26 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)) 04:34:26 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)) 04:34:26 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)) 04:34:26 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)) 04:34:26 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)) 04:34:26 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)) 04:34:26 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)) 04:34:26 INFO - Cleaning up... 04:34:26 INFO - Return code: 0 04:34:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:34:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:26 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 0x10eb73b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb76768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f984044f940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e951d30>, '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 0x10e878db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e946be8>, '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.81WDS52tjK/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.i5NQQUdRFJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/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 04:34:26 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 04:34:26 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 04:34:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.81WDS52tjK/Render', 04:34:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:34:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:34:26 INFO - 'HOME': '/Users/cltbld', 04:34:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:34:26 INFO - 'LOGNAME': 'cltbld', 04:34:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:26 INFO - 'MOZ_NO_REMOTE': '1', 04:34:26 INFO - 'NO_EM_RESTART': '1', 04:34:26 INFO - 'PAGER': '/bin/cat', 04:34:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:34:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:26 INFO - 'PWD': '/builds/slave/test', 04:34:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:34:26 INFO - 'SHELL': '/bin/bash', 04:34:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i5NQQUdRFJ/Listeners', 04:34:26 INFO - 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/', 04:34:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:34:26 INFO - 'USER': 'cltbld', 04:34:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:34:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:34:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:26 INFO - 'XPC_FLAGS': '0x0', 04:34:26 INFO - 'XPC_SERVICE_NAME': '0', 04:34:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:34:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:34:26 INFO - Cleaning up... 04:34:26 INFO - Return code: 0 04:34:26 INFO - Running post-action listener: _resource_record_post_action 04:34:26 INFO - Running post-action listener: _start_resource_monitoring 04:34:26 INFO - Starting resource monitoring. 04:34:26 INFO - [mozharness: 2017-04-08 11:34:26.815185Z] Finished create-virtualenv step (success) 04:34:26 INFO - [mozharness: 2017-04-08 11:34:26.816221Z] Running install step. 04:34:26 INFO - Running pre-action listener: _resource_record_pre_action 04:34:26 INFO - Running main action method: install 04:34:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:34:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:34:27 INFO - Reading from file tmpfile_stdout 04:34:27 INFO - Detecting whether we're running mozinstall >=1.0... 04:34:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:34:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:34:27 INFO - Reading from file tmpfile_stdout 04:34:27 INFO - Output received: 04:34:27 INFO - Usage: mozinstall [options] installer 04:34:27 INFO - Options: 04:34:27 INFO - -h, --help show this help message and exit 04:34:27 INFO - -d DEST, --destination=DEST 04:34:27 INFO - Directory to install application into. [default: 04:34:27 INFO - "/builds/slave/test"] 04:34:27 INFO - --app=APP Application being installed. [default: firefox] 04:34:27 INFO - mkdir: /builds/slave/test/build/application 04:34:27 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'] 04:34:27 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 04:34:46 INFO - Reading from file tmpfile_stdout 04:34:46 INFO - Output received: 04:34:46 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 04:34:46 INFO - Running post-action listener: _resource_record_post_action 04:34:46 INFO - [mozharness: 2017-04-08 11:34:46.981452Z] Finished install step (success) 04:34:46 INFO - [mozharness: 2017-04-08 11:34:46.981638Z] Running run-tests step. 04:34:46 INFO - Running pre-action listener: _resource_record_pre_action 04:34:46 INFO - Running main action method: run_tests 04:34:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:34:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:34:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:34:46 INFO - 2017-04-08 04:34:46.996 screenresolution[2351:45328] starting screenresolution argv=screenresolution get 04:34:46 INFO - 2017-04-08 04:34:46.999 screenresolution[2351:45328] Display 0: 1600x1200x32@60 04:34:47 INFO - 2017-04-08 04:34:47.005 screenresolution[2352:45331] starting screenresolution argv=screenresolution list 04:34:47 INFO - Available Modes on Display 0 04:34:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:34:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:34:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:34:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:34:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:34:47 INFO - Intel Iris: 04:34:47 INFO - Chipset Model: Intel Iris 04:34:47 INFO - Type: GPU 04:34:47 INFO - Bus: Built-In 04:34:47 INFO - VRAM (Dynamic, Max): 1536 MB 04:34:47 INFO - Vendor: Intel (0x8086) 04:34:47 INFO - Device ID: 0x0a2e 04:34:47 INFO - Revision ID: 0x0009 04:34:47 INFO - Displays: 04:34:47 INFO - Display: 04:34:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:34:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:34:47 INFO - Display Serial Number: 1600x1200 60 04:34:47 INFO - Main Display: Yes 04:34:47 INFO - Mirror: Off 04:34:47 INFO - Online: Yes 04:34:47 INFO - Rotation: Supported 04:34:47 INFO - Return code: 0 04:34:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:34:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:34:47 INFO - Python 2.7.3 04:34:47 INFO - Return code: 0 04:34:47 INFO - grabbing minidump binary from tooltool 04:34:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:47 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 0x10e951d30>, '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 0x10e878db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e946be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:34:47 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 04:34:47 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 04:34:47 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 04:34:47 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:34:47 INFO - Return code: 0 04:34:47 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:34:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:34:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:34:47 INFO - ENV: RUST_BACKTRACE is now 1 04:34:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:34:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:34:47 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ExvM5Va5Sw28xw6LSai0rw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0018', '--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 04:34:47 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/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ExvM5Va5Sw28xw6LSai0rw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0018 --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 04:34:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.81WDS52tjK/Render', 04:34:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:34:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:34:47 INFO - 'HOME': '/Users/cltbld', 04:34:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:34:47 INFO - 'LOGNAME': 'cltbld', 04:34:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:34:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:34:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:47 INFO - 'MOZ_NO_REMOTE': '1', 04:34:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:34:47 INFO - 'NO_EM_RESTART': '1', 04:34:47 INFO - 'PAGER': '/bin/cat', 04:34:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:34:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:47 INFO - 'PWD': '/builds/slave/test', 04:34:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:34:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:34:47 INFO - 'RUST_BACKTRACE': '1', 04:34:47 INFO - 'SHELL': '/bin/bash', 04:34:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i5NQQUdRFJ/Listeners', 04:34:47 INFO - 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/', 04:34:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:34:47 INFO - 'USER': 'cltbld', 04:34:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:34:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:34:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:47 INFO - 'XPC_FLAGS': '0x0', 04:34:47 INFO - 'XPC_SERVICE_NAME': '0', 04:34:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:34:47 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ExvM5Va5Sw28xw6LSai0rw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0018', '--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 04:34:47 INFO - mozversion application_buildid: 20170408030204 04:34:47 INFO - mozversion application_changeset: 35c7be9c2db288d1d449e3cc586c4164d642c5fd 04:34:47 INFO - mozversion application_display_name: Nightly 04:34:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:34:47 INFO - mozversion application_name: Firefox 04:34:47 INFO - mozversion application_remotingname: firefox 04:34:47 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:34:47 INFO - mozversion application_vendor: Mozilla 04:34:47 INFO - mozversion application_version: 55.0a1 04:34:47 INFO - mozversion platform_buildid: 20170408030204 04:34:47 INFO - mozversion platform_changeset: 35c7be9c2db288d1d449e3cc586c4164d642c5fd 04:34:47 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:34:47 INFO - mozversion platform_version: 55.0a1 04:34:47 INFO - using testdate: 1491651287 04:34:47 INFO - actual date: 1491651287 04:34:47 INFO - starting webserver on 'localhost:61568' 04:34:47 INFO - SUITE-START | Running 2 tests 04:34:47 INFO - TEST-START | dromaeo_css 04:34:47 INFO - operating with platform_type : mac_ 04:34:47 INFO - Initialising browser for dromaeo_css test... 04:34:47 INFO - TEST-INFO | started process 2362 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/tmp0uKrz_/profile http://localhost:61568/getInfo.html) 04:34:51 INFO - PID 2362 | 2017-04-08 04:34:50.993 plugin-container[2365:45503] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x903f, name = 'com.apple.tsm.portname' 04:34:51 INFO - PID 2362 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:34:51 INFO - PID 2362 | 2017-04-08 04:34:50.994 plugin-container[2365:45503] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x960b, name = 'com.apple.CFPasteboardClient' 04:34:51 INFO - PID 2362 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:34:51 INFO - PID 2362 | 2017-04-08 04:34:50.994 plugin-container[2365:45503] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:34:51 INFO - PID 2362 | __metrics Screen width/height:1600/1200 04:34:51 INFO - PID 2362 | colorDepth:24 04:34:51 INFO - PID 2362 | Browser inner width/height: 1024/689 04:34:51 INFO - PID 2362 | __metrics 04:34:51 ERROR - PID 2362 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3364: TypeError: this.tabs is undefined 04:34:52 INFO - TEST-INFO | 2362: exit 0 04:34:52 INFO - Browser initialized. 04:34:52 INFO - Running cycle 1/1 for dromaeo_css test... 04:34:52 INFO - TEST-INFO | started process 2366 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/tmp0uKrz_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:34:54 INFO - PID 2366 | 2017-04-08 04:34:54.897 plugin-container[2367:45633] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x892f, name = 'com.apple.tsm.portname' 04:34:54 INFO - PID 2366 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:34:54 INFO - PID 2366 | 2017-04-08 04:34:54.898 plugin-container[2367:45633] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 04:34:54 INFO - PID 2366 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:34:54 INFO - PID 2366 | 2017-04-08 04:34:54.898 plugin-container[2367:45633] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:35:04 INFO - PID 2366 | RSS: Main: 233631744 04:35:04 INFO - PID 2366 | 04:38:08 INFO - PID 2366 | Cycle 1(1): loaded http://localhost:61568/tests/dromaeo/cssquery-dojo.html (next: http://localhost:61568/tests/dromaeo/cssquery-ext.html) 04:38:10 INFO - PID 2366 | RSS: Main: 252272640 04:38:10 INFO - PID 2366 | 04:39:52 INFO - PID 2366 | ************************* 04:39:52 INFO - PID 2366 | A coding exception was thrown and uncaught in a Task. 04:39:52 INFO - PID 2366 | 04:39:52 ERROR - PID 2366 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:39:52 INFO - PID 2366 | Full stack: 04:39:52 INFO - PID 2366 | ************************* 04:39:52 INFO - PID 2366 | ************************* 04:39:52 INFO - PID 2366 | A coding exception was thrown and uncaught in a Task. 04:39:52 INFO - PID 2366 | 04:39:52 ERROR - PID 2366 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:39:52 INFO - PID 2366 | Full stack: 04:39:52 INFO - PID 2366 | ************************* 04:39:52 INFO - PID 2366 | ************************* 04:39:52 INFO - PID 2366 | A coding exception was thrown and uncaught in a Task. 04:39:52 INFO - PID 2366 | 04:39:52 ERROR - PID 2366 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:39:52 INFO - PID 2366 | Full stack: 04:39:52 INFO - PID 2366 | ************************* 04:39:52 INFO - PID 2366 | ************************* 04:39:52 INFO - PID 2366 | A coding exception was thrown and uncaught in a Task. 04:39:52 INFO - PID 2366 | 04:39:52 ERROR - PID 2366 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:39:52 INFO - PID 2366 | Full stack: 04:39:52 INFO - PID 2366 | ************************* 04:41:12 INFO - PID 2366 | Cycle 1(1): loaded http://localhost:61568/tests/dromaeo/cssquery-ext.html (next: http://localhost:61568/tests/dromaeo/cssquery-jquery.html) 04:41:13 INFO - PID 2366 | RSS: Main: 261914624 04:41:13 INFO - PID 2366 | 04:44:15 INFO - PID 2366 | Cycle 1(1): loaded http://localhost:61568/tests/dromaeo/cssquery-jquery.html (next: http://localhost:61568/tests/dromaeo/cssquery-mootools.html) 04:44:15 INFO - PID 2366 | RSS: Main: 273104896 04:44:15 INFO - PID 2366 | 04:47:17 INFO - PID 2366 | Cycle 1(1): loaded http://localhost:61568/tests/dromaeo/cssquery-mootools.html (next: http://localhost:61568/tests/dromaeo/cssquery-prototype.html) 04:47:18 INFO - PID 2366 | RSS: Main: 265404416 04:47:18 INFO - PID 2366 | 04:50:20 INFO - PID 2366 | Cycle 1(1): loaded http://localhost:61568/tests/dromaeo/cssquery-prototype.html (next: http://localhost:61568/tests/dromaeo/cssquery-yui.html) 04:50:21 INFO - PID 2366 | RSS: Main: 278900736 04:50:21 INFO - PID 2366 | 04:53:23 INFO - PID 2366 | Cycle 1(1): loaded http://localhost:61568/tests/dromaeo/cssquery-yui.html (next: http://localhost:61568/tests/dromaeo/cssquery-dojo.html) 04:53:23 INFO - PID 2366 | RSS: Main: 272461824 04:53:23 INFO - PID 2366 | 04:53:23 INFO - PID 2366 | __start_tp_report 04:53:23 INFO - PID 2366 | _x_x_mozilla_page_load 04:53:23 INFO - PID 2366 | _x_x_mozilla_page_load_details 04:53:23 INFO - PID 2366 | |i|pagename|runs| 04:53:23 INFO - PID 2366 | |0;dojo.html;3000.7149320814515;3615.1323682316242;3626.782393056415;3639.836207370668;3679.466477360783;6005.759769609211;6173.228346456693;6380.074889141078;6408.583442076268;6409.647469389193;5149.691018538881;6245.687715614224;6288.213973253343;6403.327650596691;6430.196225471816;5017.59859211264;5541.196526503654;5627.465390787879;5670.971645141789;5757.68332741699;5522.972385138069;5625.8593535161535;5717;5728.112142617901;5807;4532.637389008872;5613.129964855454;5689.089745640719;5700.7149642518125;5771.653700777967;5619.241402410663;5620.1288800236025;5645.520130788888;5646.971765141189;5704.515116215127;5545.390007099216;5546.528545073674;5578.30271216098;5590.049691552405;5610.354809196954;5009.398872135367;6197.814065577994;6267.498600112026;6324.462420694246;6387.872242555123;6859.31406859315;6878.415334696557;6887.862242755117;6891.483138764563;6907.689153988083;6951.89572156418;6983.790486285368;6994.195667498252;6999.265077166926;7002.474814388941;6197.721102550396;6333.176687030748;6447.2263328400895;6467.676616169173;6475.870482590321;7034.366906978396;7073.32803383688;7095.50331476802;7119.75080872167;7121.5727056375745;6465.321141280192;6601.3728695773825;6602.7028783704845;6743.190817101881;6816.318368163244;6882.724691012403;6914.377706006383;6975.162980442379;7013.824654383579;7022.40309573692;6603.636799976048;6914.9308506915295;6922.342377474132;6933.791986240421;6938.993845892317;6036.702109046576;6208.658523781145;6862.897056544156;6875.828104297432;6909.550879192836;5504.119340905436;5506.779728810803;5507.779688812403;5537.58468114893;5549.972250138804;4888.706677599355;4890.975545122252;4902.240152776254;4907.214845624683;4934.679245849008;5342.759575819097;5598.076317407664;5670.914936275959;6392.232932048091;6453.709583068773;6942.895856562156;6961.338672826073;7003.089598352181;7004.824879377954;7010.824729381806;6402.135711678864;6421.839454013593;6464.385883341075;6470;6509.967450162813;6019.729112189962;6123.234595675541;6132.110843927606;6177.876442471125;6216.658083805434;6972.546784458994;7077.292270773088;7084.2915708428745;7149.213586505584;7161.4270858330165;6971.686274117778;7013.649317534205;7031.050808140835;7034;7034.964825175842;7027;7156.141263048259;7163.10461192351;7170.2471240519;7205.963970180115;6607.3062328456745;6695.230048544479;6753.223379311442;6819.147606549182;6830.658467076527;6997.475189360716;6998.580085194701;7000.649967501707;7006.824829379307;7023.648817558999;5798.333191682842;6515.218173819172;6579.276279609335;6585.341465853377;6647.069410282467;6732.259451460433;6733.562318449285;6738.056672065817;6742.595444273163;6769.4922880785125;6313.715882785377;6423.743050277936;6532.869342613026;6615.66921653925;6641.634710090992;6384.042393640991;6574.934250657623;6681;6705.8323541909895;6754.0881980931945;5889.009077268985;6615.5038372123245;6615.768448104293;6629.171353580802;6633.038209459698 04:53:23 INFO - PID 2366 | |1;ext.html;781.4998401023345;810.5258423822062;1059.8781140168883;1262.8737126287378;1274.4519856461718;34170.829145854266;34692.826535867316;36338.63661363389;37880.24239515208;37894.8105259474;32892.84875029374;34745.30509389817;36958.26083478335;37238.62761372385;37425;7826.295633393008;8475.703350382737;8706.129387061275;8710.21608055275;8732.956335218347;8517.616707248158;8558.229759321659;8619.439736417144;8635.611397487097;8650.178233067849;8562.400631955765;8573.356998225127;8618.56907154643;8632.482051076924;8639.568021598927;8571.100034496381;8585.141485851427;8592.355573331963;8603.31173506118;8632.2662573681;8456.78858028548;8473.322134229309;8495.915040849635;8551.700690475804;8559;36370.63629363699;36617;36623.81688091542;36760.448593271125;36833.631663683285;3521.172524456776;3555.5733312002467;3562.590302115264;3583.6416358364218;3589.3898037333715;30006.099817005525;30026.699733002828;30040.399192016255;30072.69927300721;30097.849510752527;2551.4004209011055;2991.4017196560776;3218.4045951499047;3219.613646362428;3235.1750303672648;273948;276355;277787.61106194544;278117;280009;39369;40258.39612405816;47424;47991.28013079806;48502.02995940132;40176.598234017285;49674.254886176735;49784.257550985545;50213;50530;14267.714645707028;14277.214753188675;14393.568192954228;14420.495282665266;14426.639334016734;11498.195126341243;11531.48108335127;11556.768864622829;11754.823677644843;11773.823392649118;13205.603831885059;13292.867071329356;13414.262215578041;13485;13520.59438216855;5063.759378952181;5970.462658360769;5970.791022314198;5992.64044157352;6054.636721796706;995.6266400099962;1014.4471263161595;1025.8050970315617;1049.8897615750388;1059.9099076578577;22183.66724499134;23228.41928951756;23436.296911092693;24221.51556968886;24360.634590481157;1106.778644271149;1107.479484642233;1143.674052894921;1147.460693474066;1154.578578818742;11698.88301116995;12200.633980980585;12201.267923924594;12213.572524961584;12265.509379624715;352934;357586;358508;358830;359898;37087.629123708415;52395.47604523906;52917;53153.46846531485;53155.468445315055;1510.652549913526;1511.7430036893975;1549.1944189021647;1556.3930067273773;1559.7582374731935;23805.64291535663;23892.761072389054;23906.163284284965;23949.28152155438;24056;35513;36941.63058369382;37181.62818371782;37276.57702249345;37316.626833731316;318297.40851295594;320596;322986;323115;323475;26589.601155983062;33244;33332.666673332955;34039.65960340365;34245.486317705756;42868;43529;43709.907252318946;43743.34384984292;43789;28775.712242877304;30063.398732025675;30480.390392191588;30997.53503697401;31309;26542.867285663448;28512.57231141576;29878.402431951676;29962;30261.848690756404;29518.376489292437;34355.4846677305;36130.63869361273;36737.26525469422;36810.87107595884;29475;30730.23174420568;30981.91563295274;31307.373852522367;31619.525707113953;19523.70714439313;21749.891250543646;23851;24027.159049433187;24333 04:53:23 INFO - PID 2366 | |2;jquery.html;376.2099590859196;400.13171418022887;427.35042735042754;427.3674961057633;449.26096571140454;19557.41327760166;21382.25162119326;21936.670949935742;21987.120515179373;22033;17782.733259001125;22623.868806559687;23362.64956025661;23434.64848027281;23469.64795528064;6027;6352.269489008777;6354.364563543655;6362;6391.456726178257;6169.475594574466;6171.783987560436;6186.350433204516;6229.1902052733085;6317.210348706411;6265.968670156665;6290.21372328459;6300.180976473052;6301.243850737895;6310.558260921737;5651.8587035324035;6236.906446403307;6273.811785646438;6280.560360774748;6283.340249273829;5598;5614.29821272341;5627.099664053772;6651.301613330627;6988.61562614056;22620.773792262033;29425.411491770046;29485.115446536638;29957.400851983057;30065.549016764766;2262.7058482397347;2342.133410638075;2346.1084787780533;2346.671465994762;2346.894389752448;16197.595060123473;19052.047397630064;19328.806711932983;19443.513912152168;20136.49658758528;2318.304508647416;2353.482233908537;2388.9402764931015;2401.5076909233567;2414.6740190074293;167541;171902;171962;172719;173393;19835.404937851887;24272.63591046136;24660.876695616407;25069.87465062663;25159.748402516107;41091.794541027106;41846.790766045975;41887.790561047;42117.15765684669;42160.36759448611;8001.959990200012;8855.87459009833;9105.408148470327;9228.5847136879;9269.72190834276;6535.934640653628;7183.389411899942;8595.65617375298;8619.094995025558;8772.605232764541;8040;8149.429539932148;8203.58982050895;8222.671093156327;8231.365962891938;2136.305700647296;2211.347652442533;2220.100859152046;2221.7556068832414;2225.121077174507;933.5332333833084;956.5695437053354;971.1732688537955;972.1396564040875;1006.8187726209206;19409.126589303516;19862;21633.675494867588;21646;21837.45406364822;983.9950800245953;989.4557993103908;1013.3160116921049;1018.8675472188568;1021.3361315145215;11123.833142502868;11345.489452974636;11346.48940797666;11350;11375.03312218454;679157;687368;708926;714590;723196.6082035095;127702.36148819383;133026;160351;163324.3667563333;169841.60316793594;1158.5076342554548;1165.405643121997;1192.7256730951929;1193.421190722499;1194.1819853400448;18268.725969110208;18861.434156975312;18888;18947.810521894604;18954.810451895304;65682;66510;66585.66707166433;66828.6658566704;67638.32361676518;95527;95988.0401195979;97554;97853.51073244588;99097.50451247698;8798.252148567188;8918.910810891808;8932.508712020901;9050.27597792162;9463.101005404476;14442.711145777235;14524.49164279245;14686.706265874409;14867.776983345042;14975.400983960519;12123.636290911287;12219.633410997685;12245.265284082983;12264.509419623115;12303.261804291771;11544.365059921785;11608.01331886799;11720.296782193096;11949.984251338734;12024.579139730067;12008.879911200776;12279.44742486608;12379.257244565355;12380.938095309466;12443.93778031104;7513.924860751541;8938.597763100546;9165.77085572866;9186.494742788944;9197.724068277963;11517.827232591686;11920.642380728592;11987.40062996864;12233.510659573518;12349.876501234872 04:53:23 INFO - PID 2366 | |3;mootools.html;1380.2339701465685;1401.6916278418744;1419.4535103984963;1426.9357878895448;1443.5597142871422;11217.326960382372;11684.182107252496;11717.179797414185;11752.706182345446;11857.703557411069;11543.538258469673;11737.354445505494;11755.882441175585;11769.293842369443;11817.290962542253;2460.6186041163605;2485.3289611804803;2487.6890388701413;2490.340059884123;2490.9750902490923;2381.095183830142;2410.4455975125734;2457.1154384421593;2457.127719659522;2459.9016039358403;2409.108629806974;2409.9397515062087;2428.162284012013;2444.2545023767743;2453.116877923946;2362.2322745107735;2414.7223069346987;2424.963625545627;2428.514297140561;2436.658867758515;2004.7093171490199;2369.0642196332524;2429.7205821330595;2433.7687919647783;2438.5244877248942;10366.688999330032;11000.954909283606;11681;11807.055435565135;11822.231554948901;5482.150266708666;6514.837129071811;6515.4787616990525;6516.478681705452;6517.674116294166;3882.6699730522655;4153.958460415418;4170.70805043647;4222.873313800591;4234.237837189305;1033.5917312661531;1263.943122559487;1270.7458508298284;1308.8887444567224;1312.960611181666;13343.132696374705;13525.256110913993;16163.19184040805;16226.918865405716;16261.674766504722;4268.701190916606;4459.353393757887;5232.738363081907;5383.865403364947;5427.83716488506;12253.203541769757;12301.75396492083;12364.44360003802;12374.257544547176;12379.93810030944;6478.4169424752;6485.156929599122;6496.252930912911;6505.121808555879;6510.3489651034515;5889.263842019747;6000.759969601254;6001.879962400728;6097.4817140543555;6105.32841387447;4373.343998400265;4418.138462999748;4464.3973063635995;4504.572065653758;4533.705309154961;1286.8648791876906;1306.5231190615357;1310.194230548225;1322.4049177869804;1322.7751282282036;571.3429556010537;782.7377828427427;798.9880151797728;800.3117319105564;804.7505273365275;5581.469760372758;5915.7633694652595;5932.940670593325;6948.096747422803;6986.336298051677;819.6434550970347;823.7940514871282;896.4038914122036;942.0861764088822;952.2762700347647;3472.8886756238267;3876.9612303877166;4130.938035929464;4260.595243451867;4334.523202447728;14576.927115364355;15364.539063828102;15385.153816540198;15385.615359616098;15393.846061539465;14870.925645371704;15067.171305578078;15173.93782435219;15221;15280.006799557994;10648.627298044687;10826;10844.96972787584;10967.561297548009;11008.339499629888;6594.307597702172;7077.832157693922;7117.928820711727;7129.679164437509;7303.9044143378915;13325.200487970753;13565.389557470135;13695.383707732977;13705.931470342584;13749.450021999008;13596.728065438438;13640.931795340959;13718.45126194941;13963.720725585228;14175.93680473948;7477.364424024019;8503.23470887623;8922.776930576787;8934.329925255763;8944.016158222461;10685.786284274427;10750.731231718957;10773.946130269613;10842.783144337227;10900.618478353219;7971.844082608105;9122.179003889682;9211.953940230256;9261.120193581599;9264.583093760932;9095.045020272775;9113.544322783702;9113.589888455168;9177.678781242625;9292.256619470561;8178.877316840371;8340.582970851312;8355.498670079814;8370.58147092655;8389.454685445426;5321.840344789663;6031.819045428644;6051.727672254671;6164.845878853064;6272.5922815016875;6072.453479186895;6095.817125486243;6256.217972753406;6277;6299.622022678654 04:53:23 INFO - PID 2366 | |4;prototype.html;266.45376977196753;370.49612526963307;379.7588531282636;384.7076222071225;385.3141408293237;5289.285946397235;5534.252875861763;6121.938780612204;6298.338674439186;6498.090267362573;5057.898842023157;6115.633062016271;6296.496280297565;6304.401081897213;6370.108184854124;3847.019010152407;4233.51314598822;4441.133978874121;4769.284607308914;4782.210935195706;4611.907761844761;4720.693154944935;4744.715317080986;4749.976250118744;4756.429228492569;4369.798305465991;4645.140648979933;4663.48701642819;4681.414823147106;4684.859454216362;4717.268823332389;4727.409073865767;4737;4746.21687421575;4751.643626727975;4081.2245673321972;4087.2438598859007;4115.444415003966;4126.587341265879;4181.351890456954;5329.307190065267;6077.483413909823;6126.571140020201;6274.235458724775;6288.779892703779;5330.493603107738;5634.154876768476;5650.773969041234;5663;5706.058500347438;5724.427557244284;6751.392374686302;6769.153855768029;6812.250652428229;6841.144856892888;4695.849516868355;4741.905161896742;4746.857594272177;4749.833755818529;4759;6236.719347629322;6707.295733947914;6962.268961758993;7141.928580714179;7186.670465963761;4774.618030557547;4777.423450261405;4814.927776083362;4815.2054910939305;4822.831200907952;4898.387701537308;4903.632227582874;4914.311996320518;4937.580305673986;4947.381577302837;4710.26990816424;5175.378954525481;5390.571498552887;5613.747381367848;5653.632513886584;5895.027320492157;6122.418370254819;6308.801327747713;6852.211995620468;6871;1412.6468382904275;1500.3421219552456;1556.4552406657579;1560.0327796766078;1563.2105786577706;793.1275596843426;955.8040601676639;998.286225348879;999.81003609314;1005.969820905374;6213.844653883599;6267.0286105652785;6279.434850863444;6285.371462853769;6323.20959880015;6633.86732265352;6919.40853603674;6955.89566156508;6960.129983752031;7001.50989430735;6152.815415537541;6235.563510554309;6255.779198384599;6273.780417685359;6291.213598300213;3052.6947305269296;3520.9471857922154;3588.515550400715;3607.2424790793702;3623.065317093163;6323.494120470351;6791.558548694319;7032.226455089936;7104.396126329217;7176.102987126609;5225.921611175835;5270;6393.424591786761;6760.864782704319;6812.420944219698;4719.5044520325555;6128.693565321716;6885.690143943534;7040.647967601702;7043.788686339521;7071.398931090915;7072.292770722886;7072.328128827753;7113.964430177816;7123.180834204133;5846.970765146147;6643.302453242533;6745.763898263537;6950.853109237121;6953;7209.6034718091005;7214.74748383804;7231.891521627285;7239.638018098969;7283.781486555412;4324.978375108104;4422.3587579800105;4463.687541872037;4491.640668746427;4491.73049617024;6450.41946224842;6590.780705569485;6943.166819981635;7011.404030657452;7093.184283807428;6234.9688251558455;6280.214973128359;6425.871482570229;6792.592444453348;6796.150481189851;5873.559483038704;6388.284978883863;6449.8390289748295;6739.157605299338;6765.492588055817;5491.75287112073;6055.9091613626715;6064;6650.933490665225;6734.844849648066;6122.602030867979;6314.715837787218;6740.0226967090475;6758.797236082925;6805.489588280998;6630.9336906630315;6656.567323123982;6664.966675166593;6682.298358672269;6692.799216023527 04:53:23 INFO - PID 2366 | |5;yui.html;810.8256724804166;811.1928631012144;837.7444879311811;866.0646501778081;868.5483548554752;14614.050086744353;15162;16558;16947.49157525273;16974;12687.936560317186;15496.992695474786;15696.921515392436;15879.126648034353;17313.220905059272;972.7568107973025;1009.2834087797672;1011.3830563356383;1014.3964341216964;1015.1371334365804;986.6596024371617;989.2531138990089;1004.2116938203511;1004.7136566078669;1005.8239808033602;1037.4760745823348;1051.2431049644244;1052.557925671216;1053.2521909444304;1054.2988912373262;1049.0506091986765;1051.1013083813307;1051.4479898053544;1053.3837704942619;1056.5932116135266;772.447699894578;780.1301548773077;785.2108630825983;788.9763307100797;790.6995341770148;15586.688266234612;17267.222974966156;17348.65302693939;17527.211275492635;17561.736573951403;17213.311467541283;17222.741658875126;17439.38962136332;17533.03568303743;17563.29746810126;13903.652408689763;14213.644658883508;14233.50182743599;14366.425342986373;14405.92797036008;3479.2171761353748;3512.121969507623;3513.3149035938004;3516.3494753470436;3524.136586536315;125217;125789.11316330262;127590;128908;129670;11153;12403.193792403465;13394.397252123677;13504.987125965592;13582.728345433234;22452.77547224507;24400.023999040193;25561.105361312264;25940.962361505706;26014.08950686755;7586.62066896664;7676.424268179797;9075.591598378089;9201.401908876036;9204.677836275698;4735.195016847144;4837.6613637045775;4869.026194761062;4874.658773885794;4874.731889746027;4220.53574106848;4388.824447022147;4390.868273951786;4391.538888416734;4405.955940440619;785.5875665275776;956.3305686019814;962.9422234665942;970.2189737261431;976.1751320134617;641.214512222533;655.3381085104079;661.7319985405918;670.7149461478851;693.3413257405485;11080.501377438035;11764.058875289957;11934.985526230193;12034.518619255132;12190.2076365036;659.6635715784985;662.5097427903413;665.4277321503503;674.9088873002082;693.7710555516668;5152.819651312186;5361.758720857571;5483.122700367922;5524.281843360337;5546.306711661043;99368;106509.46745266224;106649.46675266574;106919.23888372273;107462;80621;80810;81747.5912620445;85344.57327713321;96809;54309.72845135828;69573;69908.60182796417;71589;72130.63934680398;12047.594700448191;12146.08904332161;12189.390530473618;12189.878101218874;12207.389630518615;30021.54967675443;34305.82847085749;40462;40727.79636101801;41469.96325091897;39374.01564960899;53152.67118322073;53284.934301312984;53738.46261537335;54342.184867226235;13450.596482105553;13572.79640805369;14214.644633884236;16142.515724528283;16482.42311519091;13987.930060349634;17578.560535986704;17698.203580838635;18022.72965905486;18313.992730399958;16005.519834404986;16182.352705891632;16189.352425903304;16410.261538231047;16423.932444391077;12082.697932551406;16169.272382742569;16639.833601663828;16706.832931671015;17382;16016.759748603547;16050.598735031717;16101.516954491384;16141.273642686343;16247.756283655992;11442.37066961325;11489.712757180803;11671.183017188716;11735.76528469443;11877.287362758263;11809.291442513477;13190.340482976006;13479.730405392034;13552.322383880964;13866.376013079234 04:53:23 INFO - PID 2366 | __end_tp_report 04:53:23 INFO - PID 2366 | __start_cc_report 04:53:23 INFO - PID 2366 | _x_x_mozilla_cycle_collect,424 04:53:23 INFO - PID 2366 | __end_cc_report 04:53:23 INFO - PID 2366 | __startTimestamp1491652403789__endTimestamp 04:53:23 INFO - PID 2366 | 04:53:23 INFO - PID 2366 | ------- Summary: start ------- 04:53:23 INFO - PID 2366 | Number of tests: 6 04:53:23 INFO - PID 2366 | 04:53:23 INFO - PID 2366 | [#0] dojo.html Cycles:165 Average:6298.95 Median:6509.97 stddev:792.68 (12.2%) stddev-sans-first:751.69 04:53:23 INFO - PID 2366 | Values: 3000.7 3615.1 3626.8 3639.8 3679.5 6005.8 6173.2 6380.1 6408.6 6409.6 5149.7 6245.7 6288.2 6403.3 6430.2 5017.6 5541.2 5627.5 5671.0 5757.7 5523.0 5625.9 5717.0 5728.1 5807.0 4532.6 5613.1 5689.1 5700.7 5771.7 5619.2 5620.1 5645.5 5647.0 5704.5 5545.4 5546.5 5578.3 5590.0 5610.4 5009.4 6197.8 6267.5 6324.5 6387.9 6859.3 6878.4 6887.9 6891.5 6907.7 6951.9 6983.8 6994.2 6999.3 7002.5 6197.7 6333.2 6447.2 6467.7 6475.9 7034.4 7073.3 7095.5 7119.8 7121.6 6465.3 6601.4 6602.7 6743.2 6816.3 6882.7 6914.4 6975.2 7013.8 7022.4 6603.6 6914.9 6922.3 6933.8 6939.0 6036.7 6208.7 6862.9 6875.8 6909.6 5504.1 5506.8 5507.8 5537.6 5550.0 4888.7 4891.0 4902.2 4907.2 4934.7 5342.8 5598.1 5670.9 6392.2 6453.7 6942.9 6961.3 7003.1 7004.8 7010.8 6402.1 6421.8 6464.4 6470.0 6510.0 6019.7 6123.2 6132.1 6177.9 6216.7 6972.5 7077.3 7084.3 7149.2 7161.4 6971.7 7013.6 7031.1 7034.0 7035.0 7027.0 7156.1 7163.1 7170.2 7206.0 6607.3 6695.2 6753.2 6819.1 6830.7 6997.5 6998.6 7000.6 7006.8 7023.6 5798.3 6515.2 6579.3 6585.3 6647.1 6732.3 6733.6 6738.1 6742.6 6769.5 6313.7 6423.7 6532.9 6615.7 6641.6 6384.0 6574.9 6681.0 6705.8 6754.1 5889.0 6615.5 6615.8 6629.2 6633.0 04:53:23 INFO - PID 2366 | 04:53:23 INFO - PID 2366 | [#1] ext.html Cycles:180 Average:46023.32 Median:33288.33 stddev:84335.63 (253.3%) stddev-sans-first:84503.81 04:53:23 INFO - PID 2366 | Values: 781.5 810.5 1059.9 1262.9 1274.5 34170.8 34692.8 36338.6 37880.2 37894.8 32892.8 34745.3 36958.3 37238.6 37425.0 7826.3 8475.7 8706.1 8710.2 8733.0 8517.6 8558.2 8619.4 8635.6 8650.2 8562.4 8573.4 8618.6 8632.5 8639.6 8571.1 8585.1 8592.4 8603.3 8632.3 8456.8 8473.3 8495.9 8551.7 8559.0 36370.6 36617.0 36623.8 36760.4 36833.6 3521.2 3555.6 3562.6 3583.6 3589.4 30006.1 30026.7 30040.4 30072.7 30097.8 2551.4 2991.4 3218.4 3219.6 3235.2 273948.0 276355.0 277787.6 278117.0 280009.0 39369.0 40258.4 47424.0 47991.3 48502.0 40176.6 49674.3 49784.3 50213.0 50530.0 14267.7 14277.2 14393.6 14420.5 14426.6 11498.2 11531.5 11556.8 11754.8 11773.8 13205.6 13292.9 13414.3 13485.0 13520.6 5063.8 5970.5 5970.8 5992.6 6054.6 995.6 1014.4 1025.8 1049.9 1059.9 22183.7 23228.4 23436.3 24221.5 24360.6 1106.8 1107.5 1143.7 1147.5 1154.6 11698.9 12200.6 12201.3 12213.6 12265.5 352934.0 357586.0 358508.0 358830.0 359898.0 37087.6 52395.5 52917.0 53153.5 53155.5 1510.7 1511.7 1549.2 1556.4 1559.8 23805.6 23892.8 23906.2 23949.3 24056.0 35513.0 36941.6 37181.6 37276.6 37316.6 318297.4 320596.0 322986.0 323115.0 323475.0 26589.6 33244.0 33332.7 34039.7 34245.5 42868.0 43529.0 43709.9 43743.3 43789.0 28775.7 30063.4 30480.4 30997.5 31309.0 26542.9 28512.6 29878.4 29962.0 30261.8 29518.4 34355.5 36130.6 36737.3 36810.9 29475.0 30730.2 30981.9 31307.4 31619.5 19523.7 21749.9 23851.0 24027.2 24333.0 04:53:23 INFO - PID 2366 | 04:53:23 INFO - PID 2366 | [#2] jquery.html Cycles:180 Average:42873.92 Median:13343.65 stddev:118287.73 (886.5%) stddev-sans-first:118576.52 04:53:23 INFO - PID 2366 | Values: 376.2 400.1 427.4 427.4 449.3 19557.4 21382.3 21936.7 21987.1 22033.0 17782.7 22623.9 23362.6 23434.6 23469.6 6027.0 6352.3 6354.4 6362.0 6391.5 6169.5 6171.8 6186.4 6229.2 6317.2 6266.0 6290.2 6300.2 6301.2 6310.6 5651.9 6236.9 6273.8 6280.6 6283.3 5598.0 5614.3 5627.1 6651.3 6988.6 22620.8 29425.4 29485.1 29957.4 30065.5 2262.7 2342.1 2346.1 2346.7 2346.9 16197.6 19052.0 19328.8 19443.5 20136.5 2318.3 2353.5 2388.9 2401.5 2414.7 167541.0 171902.0 171962.0 172719.0 173393.0 19835.4 24272.6 24660.9 25069.9 25159.7 41091.8 41846.8 41887.8 42117.2 42160.4 8002.0 8855.9 9105.4 9228.6 9269.7 6535.9 7183.4 8595.7 8619.1 8772.6 8040.0 8149.4 8203.6 8222.7 8231.4 2136.3 2211.3 2220.1 2221.8 2225.1 933.5 956.6 971.2 972.1 1006.8 19409.1 19862.0 21633.7 21646.0 21837.5 984.0 989.5 1013.3 1018.9 1021.3 11123.8 11345.5 11346.5 11350.0 11375.0 679157.0 687368.0 708926.0 714590.0 723196.6 127702.4 133026.0 160351.0 163324.4 169841.6 1158.5 1165.4 1192.7 1193.4 1194.2 18268.7 18861.4 18888.0 18947.8 18954.8 65682.0 66510.0 66585.7 66828.7 67638.3 95527.0 95988.0 97554.0 97853.5 99097.5 8798.3 8918.9 8932.5 9050.3 9463.1 14442.7 14524.5 14686.7 14867.8 14975.4 12123.6 12219.6 12245.3 12264.5 12303.3 11544.4 11608.0 11720.3 11950.0 12024.6 12008.9 12279.4 12379.3 12380.9 12443.9 7513.9 8938.6 9165.8 9186.5 9197.7 11517.8 11920.6 11987.4 12233.5 12349.9 04:53:23 INFO - PID 2366 | 04:53:23 INFO - PID 2366 | [#3] mootools.html Cycles:180 Average:7114.99 Median:2472.97 stddev:4534.36 (183.4%) stddev-sans-first:4526.60 04:53:23 INFO - PID 2366 | Values: 1380.2 1401.7 1419.5 1426.9 1443.6 11217.3 11684.2 11717.2 11752.7 11857.7 11543.5 11737.4 11755.9 11769.3 11817.3 2460.6 2485.3 2487.7 2490.3 2491.0 2381.1 2410.4 2457.1 2457.1 2459.9 2409.1 2409.9 2428.2 2444.3 2453.1 2362.2 2414.7 2425.0 2428.5 2436.7 2004.7 2369.1 2429.7 2433.8 2438.5 10366.7 11001.0 11681.0 11807.1 11822.2 5482.2 6514.8 6515.5 6516.5 6517.7 3882.7 4154.0 4170.7 4222.9 4234.2 1033.6 1263.9 1270.7 1308.9 1313.0 13343.1 13525.3 16163.2 16226.9 16261.7 4268.7 4459.4 5232.7 5383.9 5427.8 12253.2 12301.8 12364.4 12374.3 12379.9 6478.4 6485.2 6496.3 6505.1 6510.3 5889.3 6000.8 6001.9 6097.5 6105.3 4373.3 4418.1 4464.4 4504.6 4533.7 1286.9 1306.5 1310.2 1322.4 1322.8 571.3 782.7 799.0 800.3 804.8 5581.5 5915.8 5932.9 6948.1 6986.3 819.6 823.8 896.4 942.1 952.3 3472.9 3877.0 4130.9 4260.6 4334.5 14576.9 15364.5 15385.2 15385.6 15393.8 14870.9 15067.2 15173.9 15221.0 15280.0 10648.6 10826.0 10845.0 10967.6 11008.3 6594.3 7077.8 7117.9 7129.7 7303.9 13325.2 13565.4 13695.4 13705.9 13749.5 13596.7 13640.9 13718.5 13963.7 14175.9 7477.4 8503.2 8922.8 8934.3 8944.0 10685.8 10750.7 10773.9 10842.8 10900.6 7971.8 9122.2 9212.0 9261.1 9264.6 9095.0 9113.5 9113.6 9177.7 9292.3 8178.9 8340.6 8355.5 8370.6 8389.5 5321.8 6031.8 6051.7 6164.8 6272.6 6072.5 6095.8 6256.2 6277.0 6299.6 04:53:23 INFO - PID 2366 | 04:53:23 INFO - PID 2366 | [#4] prototype.html Cycles:180 Average:5428.43 Median:6127.63 stddev:1688.65 (27.6%) stddev-sans-first:1648.34 04:53:23 INFO - PID 2366 | Values: 266.5 370.5 379.8 384.7 385.3 5289.3 5534.3 6121.9 6298.3 6498.1 5057.9 6115.6 6296.5 6304.4 6370.1 3847.0 4233.5 4441.1 4769.3 4782.2 4611.9 4720.7 4744.7 4750.0 4756.4 4369.8 4645.1 4663.5 4681.4 4684.9 4717.3 4727.4 4737.0 4746.2 4751.6 4081.2 4087.2 4115.4 4126.6 4181.4 5329.3 6077.5 6126.6 6274.2 6288.8 5330.5 5634.2 5650.8 5663.0 5706.1 5724.4 6751.4 6769.2 6812.3 6841.1 4695.8 4741.9 4746.9 4749.8 4759.0 6236.7 6707.3 6962.3 7141.9 7186.7 4774.6 4777.4 4814.9 4815.2 4822.8 4898.4 4903.6 4914.3 4937.6 4947.4 4710.3 5175.4 5390.6 5613.7 5653.6 5895.0 6122.4 6308.8 6852.2 6871.0 1412.6 1500.3 1556.5 1560.0 1563.2 793.1 955.8 998.3 999.8 1006.0 6213.8 6267.0 6279.4 6285.4 6323.2 6633.9 6919.4 6955.9 6960.1 7001.5 6152.8 6235.6 6255.8 6273.8 6291.2 3052.7 3520.9 3588.5 3607.2 3623.1 6323.5 6791.6 7032.2 7104.4 7176.1 5225.9 5270.0 6393.4 6760.9 6812.4 4719.5 6128.7 6885.7 7040.6 7043.8 7071.4 7072.3 7072.3 7114.0 7123.2 5847.0 6643.3 6745.8 6950.9 6953.0 7209.6 7214.7 7231.9 7239.6 7283.8 4325.0 4422.4 4463.7 4491.6 4491.7 6450.4 6590.8 6943.2 7011.4 7093.2 6235.0 6280.2 6425.9 6792.6 6796.2 5873.6 6388.3 6449.8 6739.2 6765.5 5491.8 6055.9 6064.0 6650.9 6734.8 6122.6 6314.7 6740.0 6758.8 6805.5 6630.9 6656.6 6665.0 6682.3 6692.8 04:53:23 INFO - PID 2366 | 04:53:23 INFO - PID 2366 | [#5] yui.html Cycles:180 Average:20968.64 Median:17365.33 stddev:29694.64 (171.0%) stddev-sans-first:29739.37 04:53:23 INFO - PID 2366 | Values: 810.8 811.2 837.7 866.1 868.5 14614.1 15162.0 16558.0 16947.5 16974.0 12687.9 15497.0 15696.9 15879.1 17313.2 972.8 1009.3 1011.4 1014.4 1015.1 986.7 989.3 1004.2 1004.7 1005.8 1037.5 1051.2 1052.6 1053.3 1054.3 1049.1 1051.1 1051.4 1053.4 1056.6 772.4 780.1 785.2 789.0 790.7 15586.7 17267.2 17348.7 17527.2 17561.7 17213.3 17222.7 17439.4 17533.0 17563.3 13903.7 14213.6 14233.5 14366.4 14405.9 3479.2 3512.1 3513.3 3516.3 3524.1 125217.0 125789.1 127590.0 128908.0 129670.0 11153.0 12403.2 13394.4 13505.0 13582.7 22452.8 24400.0 25561.1 25941.0 26014.1 7586.6 7676.4 9075.6 9201.4 9204.7 4735.2 4837.7 4869.0 4874.7 4874.7 4220.5 4388.8 4390.9 4391.5 4406.0 785.6 956.3 962.9 970.2 976.2 641.2 655.3 661.7 670.7 693.3 11080.5 11764.1 11935.0 12034.5 12190.2 659.7 662.5 665.4 674.9 693.8 5152.8 5361.8 5483.1 5524.3 5546.3 99368.0 106509.5 106649.5 106919.2 107462.0 80621.0 80810.0 81747.6 85344.6 96809.0 54309.7 69573.0 69908.6 71589.0 72130.6 12047.6 12146.1 12189.4 12189.9 12207.4 30021.5 34305.8 40462.0 40727.8 41470.0 39374.0 53152.7 53284.9 53738.5 54342.2 13450.6 13572.8 14214.6 16142.5 16482.4 13987.9 17578.6 17698.2 18022.7 18314.0 16005.5 16182.4 16189.4 16410.3 16423.9 12082.7 16169.3 16639.8 16706.8 17382.0 16016.8 16050.6 16101.5 16141.3 16247.8 11442.4 11489.7 11671.2 11735.8 11877.3 11809.3 13190.3 13479.7 13552.3 13866.4 04:53:23 INFO - PID 2366 | -------- Summary: end -------- 04:53:23 INFO - PID 2366 | 04:53:24 INFO - TEST-INFO | 2366: exit 0 04:53:24 INFO - TEST-OK | dromaeo_css | took 1116826ms 04:53:24 INFO - TEST-START | kraken 04:53:24 INFO - operating with platform_type : mac_ 04:53:24 INFO - Initialising browser for kraken test... 04:53:24 INFO - TEST-INFO | started process 2371 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/tmpGN2ES0/profile http://localhost:61568/getInfo.html) 04:53:27 INFO - PID 2371 | 2017-04-08 04:53:27.766 plugin-container[2373:47798] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x893f, name = 'com.apple.tsm.portname' 04:53:27 INFO - PID 2371 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:53:27 INFO - PID 2371 | 2017-04-08 04:53:27.767 plugin-container[2373:47798] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4423, name = 'com.apple.CFPasteboardClient' 04:53:27 INFO - PID 2371 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:53:27 INFO - PID 2371 | 2017-04-08 04:53:27.768 plugin-container[2373:47798] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:53:27 INFO - PID 2371 | __metrics Screen width/height:1600/1200 04:53:27 INFO - PID 2371 | colorDepth:24 04:53:27 INFO - PID 2371 | Browser inner width/height: 1024/689 04:53:27 INFO - PID 2371 | __metrics 04:53:27 ERROR - PID 2371 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3364: TypeError: this.tabs is undefined 04:53:28 INFO - TEST-INFO | 2371: exit 0 04:53:28 INFO - Browser initialized. 04:53:28 INFO - Running cycle 1/1 for kraken test... 04:53:28 INFO - TEST-INFO | started process 2374 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/tmpGN2ES0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:53:31 INFO - PID 2374 | 2017-04-08 04:53:31.606 plugin-container[2375:47925] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b4f, name = 'com.apple.tsm.portname' 04:53:31 INFO - PID 2374 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:53:31 INFO - PID 2374 | 2017-04-08 04:53:31.607 plugin-container[2375:47925] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 04:53:31 INFO - PID 2374 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:53:31 INFO - PID 2374 | 2017-04-08 04:53:31.607 plugin-container[2375:47925] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:53:41 INFO - PID 2374 | RSS: Main: 234242048 04:53:41 INFO - PID 2374 | 04:53:44 INFO - PID 2374 | Cycle 1(1): loaded http://localhost:61568/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:61568/tests/kraken/driver.html?testName=audio-beat-detection) 04:53:45 INFO - PID 2374 | RSS: Main: 248795136 04:53:45 INFO - PID 2374 | 04:53:47 INFO - PID 2374 | Cycle 1(1): loaded http://localhost:61568/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:61568/tests/kraken/driver.html?testName=audio-dft) 04:53:48 INFO - PID 2374 | RSS: Main: 257429504 04:53:48 INFO - PID 2374 | 04:53:52 INFO - PID 2374 | Cycle 1(1): loaded http://localhost:61568/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:61568/tests/kraken/driver.html?testName=audio-fft) 04:53:52 INFO - PID 2374 | RSS: Main: 259670016 04:53:52 INFO - PID 2374 | 04:53:54 INFO - PID 2374 | Cycle 1(1): loaded http://localhost:61568/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:61568/tests/kraken/driver.html?testName=audio-oscillator) 04:53:55 INFO - PID 2374 | RSS: Main: 260562944 04:53:55 INFO - PID 2374 | 04:53:57 INFO - PID 2374 | Cycle 1(1): loaded http://localhost:61568/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:61568/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:53:57 INFO - PID 2374 | RSS: Main: 260968448 04:53:57 INFO - PID 2374 | 04:54:01 INFO - PID 2374 | Cycle 1(1): loaded http://localhost:61568/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:61568/tests/kraken/driver.html?testName=imaging-darkroom) 04:54:01 INFO - PID 2374 | RSS: Main: 266391552 04:54:01 INFO - PID 2374 | 04:54:05 INFO - PID 2374 | Cycle 1(1): loaded http://localhost:61568/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:61568/tests/kraken/driver.html?testName=imaging-desaturate) 04:54:05 INFO - PID 2374 | RSS: Main: 268513280 04:54:05 INFO - PID 2374 | 04:54:09 INFO - PID 2374 | Cycle 1(1): loaded http://localhost:61568/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:61568/tests/kraken/driver.html?testName=json-parse-financial) 04:54:09 INFO - PID 2374 | RSS: Main: 268423168 04:54:09 INFO - PID 2374 | 04:54:11 INFO - PID 2374 | Cycle 1(1): loaded http://localhost:61568/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:61568/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:54:11 INFO - PID 2374 | RSS: Main: 268115968 04:54:11 INFO - PID 2374 | 04:54:13 INFO - PID 2374 | Cycle 1(1): loaded http://localhost:61568/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:61568/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:54:14 INFO - PID 2374 | RSS: Main: 268664832 04:54:14 INFO - PID 2374 | 04:54:16 INFO - PID 2374 | Cycle 1(1): loaded http://localhost:61568/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:61568/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:54:17 INFO - PID 2374 | RSS: Main: 268869632 04:54:17 INFO - PID 2374 | 04:54:20 INFO - PID 2374 | Cycle 1(1): loaded http://localhost:61568/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:61568/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:54:21 INFO - PID 2374 | RSS: Main: 268861440 04:54:21 INFO - PID 2374 | 04:54:24 INFO - PID 2374 | Cycle 1(1): loaded http://localhost:61568/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:61568/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:54:25 INFO - PID 2374 | RSS: Main: 265756672 04:54:25 INFO - PID 2374 | 04:54:27 INFO - PID 2374 | Cycle 1(1): loaded http://localhost:61568/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:61568/tests/kraken/driver.html?testName=ai-astar) 04:54:27 INFO - PID 2374 | RSS: Main: 269086720 04:54:27 INFO - PID 2374 | 04:54:27 INFO - PID 2374 | __start_tp_report 04:54:27 INFO - PID 2374 | _x_x_mozilla_page_load 04:54:27 INFO - PID 2374 | _x_x_mozilla_page_load_details 04:54:27 INFO - PID 2374 | |i|pagename|runs| 04:54:27 INFO - PID 2374 | |0;ai-astar;110;122;122;120;120;121;121;123;119;121 04:54:27 INFO - PID 2374 | |1;audio-beat-detection;168;156;160;157;147;152;118;116;134;118 04:54:27 INFO - PID 2374 | |2;audio-dft;211;228;228;277;299;235;216;216;215;209 04:54:27 INFO - PID 2374 | |3;audio-fft;85;57;59;92;69;52;78;92;107;93 04:54:27 INFO - PID 2374 | |4;audio-oscillator;85;71;89;75;71;81;88;71;72;88 04:54:27 INFO - PID 2374 | |5;imaging-gaussian-blur;124;142;107;92;93;96;95;91;98;91 04:54:27 INFO - PID 2374 | |6;imaging-darkroom;155;104;104;100;101;106;101;100;153;139 04:54:27 INFO - PID 2374 | |7;imaging-desaturate;133;119;108;158;157;100;100;142;140;101 04:54:27 INFO - PID 2374 | |8;json-parse-financial;52;52;51;53;52;55;52;53;53;53 04:54:27 INFO - PID 2374 | |9;json-stringify-tinderbox;56;65;62;76;66;65;61;61;61;61 04:54:27 INFO - PID 2374 | |10;stanford-crypto-aes;86;87;88;99;117;114;80;96;114;113 04:54:27 INFO - PID 2374 | |11;stanford-crypto-ccm;157;146;165;177;172;171;150;164;221;182 04:54:27 INFO - PID 2374 | |12;stanford-crypto-pbkdf2;205;261;207;262;255;190;198;240;232;207 04:54:27 INFO - PID 2374 | |13;stanford-crypto-sha256-iterative;59;70;76;71;71;76;100;68;63;105 04:54:27 INFO - PID 2374 | __end_tp_report 04:54:27 INFO - PID 2374 | __start_cc_report 04:54:27 INFO - PID 2374 | _x_x_mozilla_cycle_collect,1011 04:54:27 INFO - PID 2374 | __end_cc_report 04:54:27 INFO - PID 2374 | __startTimestamp1491652467544__endTimestamp 04:54:27 INFO - PID 2374 | 04:54:27 INFO - PID 2374 | ------- Summary: start ------- 04:54:27 INFO - PID 2374 | Number of tests: 14 04:54:27 INFO - PID 2374 | 04:54:27 INFO - PID 2374 | [#0] ai-astar Cycles:10 Average:119.90 Median:121.00 stddev:3.67 (3.0%) stddev-sans-first:1.22 04:54:27 INFO - PID 2374 | Values: 110.0 122.0 122.0 120.0 120.0 121.0 121.0 123.0 119.0 121.0 04:54:27 INFO - PID 2374 | 04:54:27 INFO - PID 2374 | [#1] audio-beat-detection Cycles:10 Average:142.60 Median:154.00 stddev:19.53 (12.7%) stddev-sans-first:18.43 04:54:27 INFO - PID 2374 | Values: 168.0 156.0 160.0 157.0 147.0 152.0 118.0 116.0 134.0 118.0 04:54:27 INFO - PID 2374 | 04:54:27 INFO - PID 2374 | [#2] audio-dft Cycles:10 Average:233.40 Median:228.00 stddev:30.38 (13.3%) stddev-sans-first:31.12 04:54:27 INFO - PID 2374 | Values: 211.0 228.0 228.0 277.0 299.0 235.0 216.0 216.0 215.0 209.0 04:54:27 INFO - PID 2374 | 04:54:27 INFO - PID 2374 | [#3] audio-fft Cycles:10 Average:78.40 Median:81.50 stddev:18.45 (22.6%) stddev-sans-first:19.42 04:54:27 INFO - PID 2374 | Values: 85.0 57.0 59.0 92.0 69.0 52.0 78.0 92.0 107.0 93.0 04:54:27 INFO - PID 2374 | 04:54:27 INFO - PID 2374 | [#4] audio-oscillator Cycles:10 Average:79.10 Median:83.00 stddev:7.88 (9.5%) stddev-sans-first:8.06 04:54:27 INFO - PID 2374 | Values: 85.0 71.0 89.0 75.0 71.0 81.0 88.0 71.0 72.0 88.0 04:54:27 INFO - PID 2374 | 04:54:27 INFO - PID 2374 | [#5] imaging-gaussian-blur Cycles:10 Average:102.90 Median:92.50 stddev:17.08 (18.5%) stddev-sans-first:16.32 04:54:27 INFO - PID 2374 | Values: 124.0 142.0 107.0 92.0 93.0 96.0 95.0 91.0 98.0 91.0 04:54:27 INFO - PID 2374 | 04:54:27 INFO - PID 2374 | [#6] imaging-darkroom Cycles:10 Average:116.30 Median:105.00 stddev:23.02 (21.9%) stddev-sans-first:19.70 04:54:27 INFO - PID 2374 | Values: 155.0 104.0 104.0 100.0 101.0 106.0 101.0 100.0 153.0 139.0 04:54:27 INFO - PID 2374 | 04:54:27 INFO - PID 2374 | [#7] imaging-desaturate Cycles:10 Average:125.80 Median:136.50 stddev:23.18 (17.0%) stddev-sans-first:24.44 04:54:27 INFO - PID 2374 | Values: 133.0 119.0 108.0 158.0 157.0 100.0 100.0 142.0 140.0 101.0 04:54:27 INFO - PID 2374 | 04:54:27 INFO - PID 2374 | [#8] json-parse-financial Cycles:10 Average:52.60 Median:53.00 stddev:1.07 (2.0%) stddev-sans-first:1.12 04:54:27 INFO - PID 2374 | Values: 52.0 52.0 51.0 53.0 52.0 55.0 52.0 53.0 53.0 53.0 04:54:27 INFO - PID 2374 | 04:54:27 INFO - PID 2374 | [#9] json-stringify-tinderbox Cycles:10 Average:63.40 Median:63.50 stddev:5.27 (8.3%) stddev-sans-first:4.87 04:54:27 INFO - PID 2374 | Values: 56.0 65.0 62.0 76.0 66.0 65.0 61.0 61.0 61.0 61.0 04:54:27 INFO - PID 2374 | 04:54:27 INFO - PID 2374 | [#10] stanford-crypto-aes Cycles:10 Average:99.40 Median:86.50 stddev:14.03 (16.2%) stddev-sans-first:14.02 04:54:27 INFO - PID 2374 | Values: 86.0 87.0 88.0 99.0 117.0 114.0 80.0 96.0 114.0 113.0 04:54:27 INFO - PID 2374 | 04:54:27 INFO - PID 2374 | [#11] stanford-crypto-ccm Cycles:10 Average:170.50 Median:171.50 stddev:21.09 (12.3%) stddev-sans-first:21.79 04:54:27 INFO - PID 2374 | Values: 157.0 146.0 165.0 177.0 172.0 171.0 150.0 164.0 221.0 182.0 04:54:27 INFO - PID 2374 | 04:54:27 INFO - PID 2374 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:225.70 Median:236.00 stddev:27.56 (11.7%) stddev-sans-first:28.20 04:54:27 INFO - PID 2374 | Values: 205.0 261.0 207.0 262.0 255.0 190.0 198.0 240.0 232.0 207.0 04:54:27 INFO - PID 2374 | 04:54:27 INFO - PID 2374 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.90 Median:70.50 stddev:15.00 (21.3%) stddev-sans-first:14.61 04:54:27 INFO - PID 2374 | Values: 59.0 70.0 76.0 71.0 71.0 76.0 100.0 68.0 63.0 105.0 04:54:27 INFO - PID 2374 | -------- Summary: end -------- 04:54:27 INFO - PID 2374 | 04:54:28 INFO - TEST-INFO | 2374: exit 0 04:54:28 INFO - TEST-OK | kraken | took 64141ms 04:54:28 INFO - SUITE-END | took 1180s 04:54:28 INFO - Completed test suite (00:19:41) 04:54:28 INFO - javascript benchmark 04:54:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8022.776222594412, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3000.7149320814515, 3615.1323682316242, 3626.782393056415, 3639.836207370668, 3679.466477360783, 6005.759769609211, 6173.228346456693, 6380.074889141078, 6408.583442076268, 6409.647469389193, 5149.691018538881, 6245.687715614224, 6288.213973253343, 6403.327650596691, 6430.196225471816, 5017.59859211264, 5541.196526503654, 5627.465390787879, 5670.971645141789, 5757.68332741699, 5522.972385138069, 5625.8593535161535, 5717.0, 5728.112142617901, 5807.0, 4532.637389008872, 5613.129964855454, 5689.089745640719, 5700.7149642518125, 5771.653700777967, 5619.241402410663, 5620.1288800236025, 5645.520130788888, 5646.971765141189, 5704.515116215127, 5545.390007099216, 5546.528545073674, 5578.30271216098, 5590.049691552405, 5610.354809196954, 5009.398872135367, 6197.814065577994, 6267.498600112026, 6324.462420694246, 6387.872242555123, 6859.31406859315, 6878.415334696557, 6887.862242755117, 6891.483138764563, 6907.689153988083, 6951.89572156418, 6983.790486285368, 6994.195667498252, 6999.265077166926, 7002.474814388941, 6197.721102550396, 6333.176687030748, 6447.2263328400895, 6467.676616169173, 6475.870482590321, 7034.366906978396, 7073.32803383688, 7095.50331476802, 7119.75080872167, 7121.5727056375745, 6465.321141280192, 6601.3728695773825, 6602.7028783704845, 6743.190817101881, 6816.318368163244, 6882.724691012403, 6914.377706006383, 6975.162980442379, 7013.824654383579, 7022.40309573692, 6603.636799976048, 6914.9308506915295, 6922.342377474132, 6933.791986240421, 6938.993845892317, 6036.702109046576, 6208.658523781145, 6862.897056544156, 6875.828104297432, 6909.550879192836, 5504.119340905436, 5506.779728810803, 5507.779688812403, 5537.58468114893, 5549.972250138804, 4888.706677599355, 4890.975545122252, 4902.240152776254, 4907.214845624683, 4934.679245849008, 5342.759575819097, 5598.076317407664, 5670.914936275959, 6392.232932048091, 6453.709583068773, 6942.895856562156, 6961.338672826073, 7003.089598352181, 7004.824879377954, 7010.824729381806, 6402.135711678864, 6421.839454013593, 6464.385883341075, 6470.0, 6509.967450162813, 6019.729112189962, 6123.234595675541, 6132.110843927606, 6177.876442471125, 6216.658083805434, 6972.546784458994, 7077.292270773088, 7084.2915708428745, 7149.213586505584, 7161.4270858330165, 6971.686274117778, 7013.649317534205, 7031.050808140835, 7034.0, 7034.964825175842, 7027.0, 7156.141263048259, 7163.10461192351, 7170.2471240519, 7205.963970180115, 6607.3062328456745, 6695.230048544479, 6753.223379311442, 6819.147606549182, 6830.658467076527, 6997.475189360716, 6998.580085194701, 7000.649967501707, 7006.824829379307, 7023.648817558999, 5798.333191682842, 6515.218173819172, 6579.276279609335, 6585.341465853377, 6647.069410282467, 6732.259451460433, 6733.562318449285, 6738.056672065817, 6742.595444273163, 6769.4922880785125, 6313.715882785377, 6423.743050277936, 6532.869342613026, 6615.66921653925, 6641.634710090992, 6384.042393640991, 6574.934250657623, 6681.0, 6705.8323541909895, 6754.0881980931945, 5889.009077268985, 6615.5038372123245, 6615.768448104293, 6629.171353580802, 6633.038209459698], "value": 6244.302018110195, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [781.4998401023345, 810.5258423822062, 1059.8781140168883, 1262.8737126287378, 1274.4519856461718, 34170.829145854266, 34692.826535867316, 36338.63661363389, 37880.24239515208, 37894.8105259474, 32892.84875029374, 34745.30509389817, 36958.26083478335, 37238.62761372385, 37425.0, 7826.295633393008, 8475.703350382737, 8706.129387061275, 8710.21608055275, 8732.956335218347, 8517.616707248158, 8558.229759321659, 8619.439736417144, 8635.611397487097, 8650.178233067849, 8562.400631955765, 8573.356998225127, 8618.56907154643, 8632.482051076924, 8639.568021598927, 8571.100034496381, 8585.141485851427, 8592.355573331963, 8603.31173506118, 8632.2662573681, 8456.78858028548, 8473.322134229309, 8495.915040849635, 8551.700690475804, 8559.0, 36370.63629363699, 36617.0, 36623.81688091542, 36760.448593271125, 36833.631663683285, 3521.172524456776, 3555.5733312002467, 3562.590302115264, 3583.6416358364218, 3589.3898037333715, 30006.099817005525, 30026.699733002828, 30040.399192016255, 30072.69927300721, 30097.849510752527, 2551.4004209011055, 2991.4017196560776, 3218.4045951499047, 3219.613646362428, 3235.1750303672648, 273948.0, 276355.0, 277787.61106194544, 278117.0, 280009.0, 39369.0, 40258.39612405816, 47424.0, 47991.28013079806, 48502.02995940132, 40176.598234017285, 49674.254886176735, 49784.257550985545, 50213.0, 50530.0, 14267.714645707028, 14277.214753188675, 14393.568192954228, 14420.495282665266, 14426.639334016734, 11498.195126341243, 11531.48108335127, 11556.768864622829, 11754.823677644843, 11773.823392649118, 13205.603831885059, 13292.867071329356, 13414.262215578041, 13485.0, 13520.59438216855, 5063.759378952181, 5970.462658360769, 5970.791022314198, 5992.64044157352, 6054.636721796706, 995.6266400099962, 1014.4471263161595, 1025.8050970315617, 1049.8897615750388, 1059.9099076578577, 22183.66724499134, 23228.41928951756, 23436.296911092693, 24221.51556968886, 24360.634590481157, 1106.778644271149, 1107.479484642233, 1143.674052894921, 1147.460693474066, 1154.578578818742, 11698.88301116995, 12200.633980980585, 12201.267923924594, 12213.572524961584, 12265.509379624715, 352934.0, 357586.0, 358508.0, 358830.0, 359898.0, 37087.629123708415, 52395.47604523906, 52917.0, 53153.46846531485, 53155.468445315055, 1510.652549913526, 1511.7430036893975, 1549.1944189021647, 1556.3930067273773, 1559.7582374731935, 23805.64291535663, 23892.761072389054, 23906.163284284965, 23949.28152155438, 24056.0, 35513.0, 36941.63058369382, 37181.62818371782, 37276.57702249345, 37316.626833731316, 318297.40851295594, 320596.0, 322986.0, 323115.0, 323475.0, 26589.601155983062, 33244.0, 33332.666673332955, 34039.65960340365, 34245.486317705756, 42868.0, 43529.0, 43709.907252318946, 43743.34384984292, 43789.0, 28775.712242877304, 30063.398732025675, 30480.390392191588, 30997.53503697401, 31309.0, 26542.867285663448, 28512.57231141576, 29878.402431951676, 29962.0, 30261.848690756404, 29518.376489292437, 34355.4846677305, 36130.63869361273, 36737.26525469422, 36810.87107595884, 29475.0, 30730.23174420568, 30981.91563295274, 31307.373852522367, 31619.525707113953, 19523.70714439313, 21749.891250543646, 23851.0, 24027.159049433187, 24333.0], "value": 17384.72023476374, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.2099590859196, 400.13171418022887, 427.35042735042754, 427.3674961057633, 449.26096571140454, 19557.41327760166, 21382.25162119326, 21936.670949935742, 21987.120515179373, 22033.0, 17782.733259001125, 22623.868806559687, 23362.64956025661, 23434.64848027281, 23469.64795528064, 6027.0, 6352.269489008777, 6354.364563543655, 6362.0, 6391.456726178257, 6169.475594574466, 6171.783987560436, 6186.350433204516, 6229.1902052733085, 6317.210348706411, 6265.968670156665, 6290.21372328459, 6300.180976473052, 6301.243850737895, 6310.558260921737, 5651.8587035324035, 6236.906446403307, 6273.811785646438, 6280.560360774748, 6283.340249273829, 5598.0, 5614.29821272341, 5627.099664053772, 6651.301613330627, 6988.61562614056, 22620.773792262033, 29425.411491770046, 29485.115446536638, 29957.400851983057, 30065.549016764766, 2262.7058482397347, 2342.133410638075, 2346.1084787780533, 2346.671465994762, 2346.894389752448, 16197.595060123473, 19052.047397630064, 19328.806711932983, 19443.513912152168, 20136.49658758528, 2318.304508647416, 2353.482233908537, 2388.9402764931015, 2401.5076909233567, 2414.6740190074293, 167541.0, 171902.0, 171962.0, 172719.0, 173393.0, 19835.404937851887, 24272.63591046136, 24660.876695616407, 25069.87465062663, 25159.748402516107, 41091.794541027106, 41846.790766045975, 41887.790561047, 42117.15765684669, 42160.36759448611, 8001.959990200012, 8855.87459009833, 9105.408148470327, 9228.5847136879, 9269.72190834276, 6535.934640653628, 7183.389411899942, 8595.65617375298, 8619.094995025558, 8772.605232764541, 8040.0, 8149.429539932148, 8203.58982050895, 8222.671093156327, 8231.365962891938, 2136.305700647296, 2211.347652442533, 2220.100859152046, 2221.7556068832414, 2225.121077174507, 933.5332333833084, 956.5695437053354, 971.1732688537955, 972.1396564040875, 1006.8187726209206, 19409.126589303516, 19862.0, 21633.675494867588, 21646.0, 21837.45406364822, 983.9950800245953, 989.4557993103908, 1013.3160116921049, 1018.8675472188568, 1021.3361315145215, 11123.833142502868, 11345.489452974636, 11346.48940797666, 11350.0, 11375.03312218454, 679157.0, 687368.0, 708926.0, 714590.0, 723196.6082035095, 127702.36148819383, 133026.0, 160351.0, 163324.3667563333, 169841.60316793594, 1158.5076342554548, 1165.405643121997, 1192.7256730951929, 1193.421190722499, 1194.1819853400448, 18268.725969110208, 18861.434156975312, 18888.0, 18947.810521894604, 18954.810451895304, 65682.0, 66510.0, 66585.66707166433, 66828.6658566704, 67638.32361676518, 95527.0, 95988.0401195979, 97554.0, 97853.51073244588, 99097.50451247698, 8798.252148567188, 8918.910810891808, 8932.508712020901, 9050.27597792162, 9463.101005404476, 14442.711145777235, 14524.49164279245, 14686.706265874409, 14867.776983345042, 14975.400983960519, 12123.636290911287, 12219.633410997685, 12245.265284082983, 12264.509419623115, 12303.261804291771, 11544.365059921785, 11608.01331886799, 11720.296782193096, 11949.984251338734, 12024.579139730067, 12008.879911200776, 12279.44742486608, 12379.257244565355, 12380.938095309466, 12443.93778031104, 7513.924860751541, 8938.597763100546, 9165.77085572866, 9186.494742788944, 9197.724068277963, 11517.827232591686, 11920.642380728592, 11987.40062996864, 12233.510659573518, 12349.876501234872], "value": 11369.596956390958, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1380.2339701465685, 1401.6916278418744, 1419.4535103984963, 1426.9357878895448, 1443.5597142871422, 11217.326960382372, 11684.182107252496, 11717.179797414185, 11752.706182345446, 11857.703557411069, 11543.538258469673, 11737.354445505494, 11755.882441175585, 11769.293842369443, 11817.290962542253, 2460.6186041163605, 2485.3289611804803, 2487.6890388701413, 2490.340059884123, 2490.9750902490923, 2381.095183830142, 2410.4455975125734, 2457.1154384421593, 2457.127719659522, 2459.9016039358403, 2409.108629806974, 2409.9397515062087, 2428.162284012013, 2444.2545023767743, 2453.116877923946, 2362.2322745107735, 2414.7223069346987, 2424.963625545627, 2428.514297140561, 2436.658867758515, 2004.7093171490199, 2369.0642196332524, 2429.7205821330595, 2433.7687919647783, 2438.5244877248942, 10366.688999330032, 11000.954909283606, 11681.0, 11807.055435565135, 11822.231554948901, 5482.150266708666, 6514.837129071811, 6515.4787616990525, 6516.478681705452, 6517.674116294166, 3882.6699730522655, 4153.958460415418, 4170.70805043647, 4222.873313800591, 4234.237837189305, 1033.5917312661531, 1263.943122559487, 1270.7458508298284, 1308.8887444567224, 1312.960611181666, 13343.132696374705, 13525.256110913993, 16163.19184040805, 16226.918865405716, 16261.674766504722, 4268.701190916606, 4459.353393757887, 5232.738363081907, 5383.865403364947, 5427.83716488506, 12253.203541769757, 12301.75396492083, 12364.44360003802, 12374.257544547176, 12379.93810030944, 6478.4169424752, 6485.156929599122, 6496.252930912911, 6505.121808555879, 6510.3489651034515, 5889.263842019747, 6000.759969601254, 6001.879962400728, 6097.4817140543555, 6105.32841387447, 4373.343998400265, 4418.138462999748, 4464.3973063635995, 4504.572065653758, 4533.705309154961, 1286.8648791876906, 1306.5231190615357, 1310.194230548225, 1322.4049177869804, 1322.7751282282036, 571.3429556010537, 782.7377828427427, 798.9880151797728, 800.3117319105564, 804.7505273365275, 5581.469760372758, 5915.7633694652595, 5932.940670593325, 6948.096747422803, 6986.336298051677, 819.6434550970347, 823.7940514871282, 896.4038914122036, 942.0861764088822, 952.2762700347647, 3472.8886756238267, 3876.9612303877166, 4130.938035929464, 4260.595243451867, 4334.523202447728, 14576.927115364355, 15364.539063828102, 15385.153816540198, 15385.615359616098, 15393.846061539465, 14870.925645371704, 15067.171305578078, 15173.93782435219, 15221.0, 15280.006799557994, 10648.627298044687, 10826.0, 10844.96972787584, 10967.561297548009, 11008.339499629888, 6594.307597702172, 7077.832157693922, 7117.928820711727, 7129.679164437509, 7303.9044143378915, 13325.200487970753, 13565.389557470135, 13695.383707732977, 13705.931470342584, 13749.450021999008, 13596.728065438438, 13640.931795340959, 13718.45126194941, 13963.720725585228, 14175.93680473948, 7477.364424024019, 8503.23470887623, 8922.776930576787, 8934.329925255763, 8944.016158222461, 10685.786284274427, 10750.731231718957, 10773.946130269613, 10842.783144337227, 10900.618478353219, 7971.844082608105, 9122.179003889682, 9211.953940230256, 9261.120193581599, 9264.583093760932, 9095.045020272775, 9113.544322783702, 9113.589888455168, 9177.678781242625, 9292.256619470561, 8178.877316840371, 8340.582970851312, 8355.498670079814, 8370.58147092655, 8389.454685445426, 5321.840344789663, 6031.819045428644, 6051.727672254671, 6164.845878853064, 6272.5922815016875, 6072.453479186895, 6095.817125486243, 6256.217972753406, 6277.0, 6299.622022678654], "value": 5344.806860710044, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [266.45376977196753, 370.49612526963307, 379.7588531282636, 384.7076222071225, 385.3141408293237, 5289.285946397235, 5534.252875861763, 6121.938780612204, 6298.338674439186, 6498.090267362573, 5057.898842023157, 6115.633062016271, 6296.496280297565, 6304.401081897213, 6370.108184854124, 3847.019010152407, 4233.51314598822, 4441.133978874121, 4769.284607308914, 4782.210935195706, 4611.907761844761, 4720.693154944935, 4744.715317080986, 4749.976250118744, 4756.429228492569, 4369.798305465991, 4645.140648979933, 4663.48701642819, 4681.414823147106, 4684.859454216362, 4717.268823332389, 4727.409073865767, 4737.0, 4746.21687421575, 4751.643626727975, 4081.2245673321972, 4087.2438598859007, 4115.444415003966, 4126.587341265879, 4181.351890456954, 5329.307190065267, 6077.483413909823, 6126.571140020201, 6274.235458724775, 6288.779892703779, 5330.493603107738, 5634.154876768476, 5650.773969041234, 5663.0, 5706.058500347438, 5724.427557244284, 6751.392374686302, 6769.153855768029, 6812.250652428229, 6841.144856892888, 4695.849516868355, 4741.905161896742, 4746.857594272177, 4749.833755818529, 4759.0, 6236.719347629322, 6707.295733947914, 6962.268961758993, 7141.928580714179, 7186.670465963761, 4774.618030557547, 4777.423450261405, 4814.927776083362, 4815.2054910939305, 4822.831200907952, 4898.387701537308, 4903.632227582874, 4914.311996320518, 4937.580305673986, 4947.381577302837, 4710.26990816424, 5175.378954525481, 5390.571498552887, 5613.747381367848, 5653.632513886584, 5895.027320492157, 6122.418370254819, 6308.801327747713, 6852.211995620468, 6871.0, 1412.6468382904275, 1500.3421219552456, 1556.4552406657579, 1560.0327796766078, 1563.2105786577706, 793.1275596843426, 955.8040601676639, 998.286225348879, 999.81003609314, 1005.969820905374, 6213.844653883599, 6267.0286105652785, 6279.434850863444, 6285.371462853769, 6323.20959880015, 6633.86732265352, 6919.40853603674, 6955.89566156508, 6960.129983752031, 7001.50989430735, 6152.815415537541, 6235.563510554309, 6255.779198384599, 6273.780417685359, 6291.213598300213, 3052.6947305269296, 3520.9471857922154, 3588.515550400715, 3607.2424790793702, 3623.065317093163, 6323.494120470351, 6791.558548694319, 7032.226455089936, 7104.396126329217, 7176.102987126609, 5225.921611175835, 5270.0, 6393.424591786761, 6760.864782704319, 6812.420944219698, 4719.5044520325555, 6128.693565321716, 6885.690143943534, 7040.647967601702, 7043.788686339521, 7071.398931090915, 7072.292770722886, 7072.328128827753, 7113.964430177816, 7123.180834204133, 5846.970765146147, 6643.302453242533, 6745.763898263537, 6950.853109237121, 6953.0, 7209.6034718091005, 7214.74748383804, 7231.891521627285, 7239.638018098969, 7283.781486555412, 4324.978375108104, 4422.3587579800105, 4463.687541872037, 4491.640668746427, 4491.73049617024, 6450.41946224842, 6590.780705569485, 6943.166819981635, 7011.404030657452, 7093.184283807428, 6234.9688251558455, 6280.214973128359, 6425.871482570229, 6792.592444453348, 6796.150481189851, 5873.559483038704, 6388.284978883863, 6449.8390289748295, 6739.157605299338, 6765.492588055817, 5491.75287112073, 6055.9091613626715, 6064.0, 6650.933490665225, 6734.844849648066, 6122.602030867979, 6314.715837787218, 6740.0226967090475, 6758.797236082925, 6805.489588280998, 6630.9336906630315, 6656.567323123982, 6664.966675166593, 6682.298358672269, 6692.799216023527], "value": 4875.624919466359, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [810.8256724804166, 811.1928631012144, 837.7444879311811, 866.0646501778081, 868.5483548554752, 14614.050086744353, 15162.0, 16558.0, 16947.49157525273, 16974.0, 12687.936560317186, 15496.992695474786, 15696.921515392436, 15879.126648034353, 17313.220905059272, 972.7568107973025, 1009.2834087797672, 1011.3830563356383, 1014.3964341216964, 1015.1371334365804, 986.6596024371617, 989.2531138990089, 1004.2116938203511, 1004.7136566078669, 1005.8239808033602, 1037.4760745823348, 1051.2431049644244, 1052.557925671216, 1053.2521909444304, 1054.2988912373262, 1049.0506091986765, 1051.1013083813307, 1051.4479898053544, 1053.3837704942619, 1056.5932116135266, 772.447699894578, 780.1301548773077, 785.2108630825983, 788.9763307100797, 790.6995341770148, 15586.688266234612, 17267.222974966156, 17348.65302693939, 17527.211275492635, 17561.736573951403, 17213.311467541283, 17222.741658875126, 17439.38962136332, 17533.03568303743, 17563.29746810126, 13903.652408689763, 14213.644658883508, 14233.50182743599, 14366.425342986373, 14405.92797036008, 3479.2171761353748, 3512.121969507623, 3513.3149035938004, 3516.3494753470436, 3524.136586536315, 125217.0, 125789.11316330262, 127590.0, 128908.0, 129670.0, 11153.0, 12403.193792403465, 13394.397252123677, 13504.987125965592, 13582.728345433234, 22452.77547224507, 24400.023999040193, 25561.105361312264, 25940.962361505706, 26014.08950686755, 7586.62066896664, 7676.424268179797, 9075.591598378089, 9201.401908876036, 9204.677836275698, 4735.195016847144, 4837.6613637045775, 4869.026194761062, 4874.658773885794, 4874.731889746027, 4220.53574106848, 4388.824447022147, 4390.868273951786, 4391.538888416734, 4405.955940440619, 785.5875665275776, 956.3305686019814, 962.9422234665942, 970.2189737261431, 976.1751320134617, 641.214512222533, 655.3381085104079, 661.7319985405918, 670.7149461478851, 693.3413257405485, 11080.501377438035, 11764.058875289957, 11934.985526230193, 12034.518619255132, 12190.2076365036, 659.6635715784985, 662.5097427903413, 665.4277321503503, 674.9088873002082, 693.7710555516668, 5152.819651312186, 5361.758720857571, 5483.122700367922, 5524.281843360337, 5546.306711661043, 99368.0, 106509.46745266224, 106649.46675266574, 106919.23888372273, 107462.0, 80621.0, 80810.0, 81747.5912620445, 85344.57327713321, 96809.0, 54309.72845135828, 69573.0, 69908.60182796417, 71589.0, 72130.63934680398, 12047.594700448191, 12146.08904332161, 12189.390530473618, 12189.878101218874, 12207.389630518615, 30021.54967675443, 34305.82847085749, 40462.0, 40727.79636101801, 41469.96325091897, 39374.01564960899, 53152.67118322073, 53284.934301312984, 53738.46261537335, 54342.184867226235, 13450.596482105553, 13572.79640805369, 14214.644633884236, 16142.515724528283, 16482.42311519091, 13987.930060349634, 17578.560535986704, 17698.203580838635, 18022.72965905486, 18313.992730399958, 16005.519834404986, 16182.352705891632, 16189.352425903304, 16410.261538231047, 16423.932444391077, 12082.697932551406, 16169.272382742569, 16639.833601663828, 16706.832931671015, 17382.0, 16016.759748603547, 16050.598735031717, 16101.516954491384, 16141.273642686343, 16247.756283655992, 11442.37066961325, 11489.712757180803, 11671.183017188716, 11735.76528469443, 11877.287362758263, 11809.291442513477, 13190.340482976006, 13479.730405392034, 13552.322383880964, 13866.376013079234], "value": 8290.074786768053, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1685.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 122.0, 122.0, 120.0, 120.0, 121.0, 121.0, 123.0, 119.0, 121.0], "value": 119.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 156.0, 160.0, 157.0, 147.0, 152.0, 118.0, 116.0, 134.0, 118.0], "value": 142.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [211.0, 228.0, 228.0, 277.0, 299.0, 235.0, 216.0, 216.0, 215.0, 209.0], "value": 233.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 57.0, 59.0, 92.0, 69.0, 52.0, 78.0, 92.0, 107.0, 93.0], "value": 78.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 71.0, 89.0, 75.0, 71.0, 81.0, 88.0, 71.0, 72.0, 88.0], "value": 79.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 142.0, 107.0, 92.0, 93.0, 96.0, 95.0, 91.0, 98.0, 91.0], "value": 102.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 104.0, 104.0, 100.0, 101.0, 106.0, 101.0, 100.0, 153.0, 139.0], "value": 116.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 119.0, 108.0, 158.0, 157.0, 100.0, 100.0, 142.0, 140.0, 101.0], "value": 125.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 51.0, 53.0, 52.0, 55.0, 52.0, 53.0, 53.0, 53.0], "value": 52.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 65.0, 62.0, 76.0, 66.0, 65.0, 61.0, 61.0, 61.0, 61.0], "value": 63.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 88.0, 99.0, 117.0, 114.0, 80.0, 96.0, 114.0, 113.0], "value": 99.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 146.0, 165.0, 177.0, 172.0, 171.0, 150.0, 164.0, 221.0, 182.0], "value": 170.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [205.0, 261.0, 207.0, 262.0, 255.0, 190.0, 198.0, 240.0, 232.0, 207.0], "value": 225.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 70.0, 76.0, 71.0, 71.0, 76.0, 100.0, 68.0, 63.0, 105.0], "value": 75.9, "unit": "score"}]}]} 04:54:28 INFO - Return code: 0 04:54:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:54:28 ERROR - # TBPL SUCCESS # 04:54:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:54:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:54:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:54:28 INFO - 2017-04-08 04:54:28.835 screenresolution[2379:48315] starting screenresolution argv=screenresolution get 04:54:28 INFO - 2017-04-08 04:54:28.838 screenresolution[2379:48315] Display 0: 1600x1200x32@60 04:54:28 INFO - 2017-04-08 04:54:28.844 screenresolution[2380:48318] starting screenresolution argv=screenresolution list 04:54:28 INFO - Available Modes on Display 0 04:54:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:54:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:54:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:54:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:54:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:54:29 INFO - Intel Iris: 04:54:29 INFO - Chipset Model: Intel Iris 04:54:29 INFO - Type: GPU 04:54:29 INFO - Bus: Built-In 04:54:29 INFO - VRAM (Dynamic, Max): 1536 MB 04:54:29 INFO - Vendor: Intel (0x8086) 04:54:29 INFO - Device ID: 0x0a2e 04:54:29 INFO - Revision ID: 0x0009 04:54:29 INFO - Displays: 04:54:29 INFO - Display: 04:54:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:54:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:54:29 INFO - Display Serial Number: 1600x1200 60 04:54:29 INFO - Main Display: Yes 04:54:29 INFO - Mirror: Off 04:54:29 INFO - Online: Yes 04:54:29 INFO - Rotation: Supported 04:54:29 INFO - Return code: 0 04:54:29 INFO - Running post-action listener: _resource_record_post_action 04:54:29 INFO - [mozharness: 2017-04-08 11:54:29.089428Z] Finished run-tests step (success) 04:54:29 INFO - Running post-run listener: _resource_record_post_run 04:54:29 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 4682752; Write bytes: 521676288; Read time: 57; Write time: 1852 04:54:29 INFO - TinderboxPrint: CPU usage
54.0% 04:54:29 INFO - TinderboxPrint: I/O read bytes / time
4,682,752 / 57 04:54:29 INFO - TinderboxPrint: I/O write bytes / time
521,676,288 / 1,852 04:54:29 INFO - TinderboxPrint: CPU idle
2,210.0 (46.0%) 04:54:29 INFO - TinderboxPrint: CPU system
964.7 (20.1%) 04:54:29 INFO - TinderboxPrint: CPU user
1,631.0 (33.9%) 04:54:29 INFO - TinderboxPrint: Swap in / out
209,567,744 / 0 04:54:29 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 209441280; Write bytes: 203038720; Read time: 16073; Write time: 375 04:54:29 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 3662848; Write bytes: 311436800; Read time: 43; Write time: 1381 04:54:29 INFO - Running post-run listener: _upload_blobber_files 04:54:29 INFO - Blob upload gear active. 04:54:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:54:29 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:54:29 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'] 04:54:29 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 04:54:29 INFO - (blobuploader) - INFO - Open directory for files ... 04:54:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:54:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:54:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:54:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:54:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:54:31 INFO - (blobuploader) - INFO - Done attempting. 04:54:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:54:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:54:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:54:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:54:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:54:32 INFO - (blobuploader) - INFO - Done attempting. 04:54:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:54:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:54:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:54:32 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:54:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:54:32 INFO - (blobuploader) - INFO - Done attempting. 04:54:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:54:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:54:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:54:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:54:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:54:34 INFO - (blobuploader) - INFO - Done attempting. 04:54:34 INFO - (blobuploader) - INFO - Iteration through files over. 04:54:34 INFO - Return code: 0 04:54:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:54:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:54:34 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5824247f756c0f1f3a1b66de8bb46ac9805278e2aadd96e4e5bbbdc308d6d191f4f38c98469b9c354e03baa8ad06a3f6032d4ee384d5a5bd42fb161c1da0a850", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8ed60d7f52dc1978b0a47a30f44bc3be44479d71924a2122330daebe9415162e0ff7237b0f45942d7a6d2bf6a0ccc47e451a9335cd51543d68c4a457a2dab702", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a2090b4e2a4344c3b8eae617774dafbc96c9a6793ee44d3a228f3b391e31a5d15cceb11c676b60f14505dc1b28f182fe47d02cb216a4a6ffc10fc8a926d08fe3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/756ac244893fbc65d6e69a505458fe7427084e8e129cb3f2fe9f1bd3b8b1bb2afabba98a98f601d5af1395b4c672c4d2a38a799df2e93737b8479e5be6ba94fb"} 04:54:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:54:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:54:34 INFO - Contents: 04:54:34 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5824247f756c0f1f3a1b66de8bb46ac9805278e2aadd96e4e5bbbdc308d6d191f4f38c98469b9c354e03baa8ad06a3f6032d4ee384d5a5bd42fb161c1da0a850", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8ed60d7f52dc1978b0a47a30f44bc3be44479d71924a2122330daebe9415162e0ff7237b0f45942d7a6d2bf6a0ccc47e451a9335cd51543d68c4a457a2dab702", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a2090b4e2a4344c3b8eae617774dafbc96c9a6793ee44d3a228f3b391e31a5d15cceb11c676b60f14505dc1b28f182fe47d02cb216a4a6ffc10fc8a926d08fe3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/756ac244893fbc65d6e69a505458fe7427084e8e129cb3f2fe9f1bd3b8b1bb2afabba98a98f601d5af1395b4c672c4d2a38a799df2e93737b8479e5be6ba94fb"} 04:54:34 INFO - Running post-run listener: copy_logs_to_upload_dir 04:54:34 INFO - Copying logs to upload dir... 04:54:34 INFO - mkdir: /builds/slave/test/build/upload/logs 04:54:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1292.813301 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 32 secs) (at 2017-04-08 04:54:34.809120) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-08 04:54:34.812671) ========= 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.81WDS52tjK/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.i5NQQUdRFJ/Listeners TMPDIR=/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/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/5824247f756c0f1f3a1b66de8bb46ac9805278e2aadd96e4e5bbbdc308d6d191f4f38c98469b9c354e03baa8ad06a3f6032d4ee384d5a5bd42fb161c1da0a850", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8ed60d7f52dc1978b0a47a30f44bc3be44479d71924a2122330daebe9415162e0ff7237b0f45942d7a6d2bf6a0ccc47e451a9335cd51543d68c4a457a2dab702", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a2090b4e2a4344c3b8eae617774dafbc96c9a6793ee44d3a228f3b391e31a5d15cceb11c676b60f14505dc1b28f182fe47d02cb216a4a6ffc10fc8a926d08fe3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/756ac244893fbc65d6e69a505458fe7427084e8e129cb3f2fe9f1bd3b8b1bb2afabba98a98f601d5af1395b4c672c4d2a38a799df2e93737b8479e5be6ba94fb"} build_url:https://queue.taskcluster.net/v1/task/ExvM5Va5Sw28xw6LSai0rw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011566 build_url: 'https://queue.taskcluster.net/v1/task/ExvM5Va5Sw28xw6LSai0rw/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/5824247f756c0f1f3a1b66de8bb46ac9805278e2aadd96e4e5bbbdc308d6d191f4f38c98469b9c354e03baa8ad06a3f6032d4ee384d5a5bd42fb161c1da0a850", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8ed60d7f52dc1978b0a47a30f44bc3be44479d71924a2122330daebe9415162e0ff7237b0f45942d7a6d2bf6a0ccc47e451a9335cd51543d68c4a457a2dab702", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a2090b4e2a4344c3b8eae617774dafbc96c9a6793ee44d3a228f3b391e31a5d15cceb11c676b60f14505dc1b28f182fe47d02cb216a4a6ffc10fc8a926d08fe3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/756ac244893fbc65d6e69a505458fe7427084e8e129cb3f2fe9f1bd3b8b1bb2afabba98a98f601d5af1395b4c672c4d2a38a799df2e93737b8479e5be6ba94fb"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-08 04:54:34.848310) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-08 04:54:34.848638) ========= 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.81WDS52tjK/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.i5NQQUdRFJ/Listeners TMPDIR=/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/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.005297 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-08 04:54:34.897186) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-08 04:54:34.897547) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-08 04:54:34.897877) ========= ========= Total master_lag: 0.18 =========