builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0341 starttime: 1488983719.69 results: success (0) buildid: 20170308051923 builduid: 7462c4e2ace840a7b4b9360d7dd28a7b revision: becff35a0bed14b536bb0a141b0e9640e9cb063d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-08 06:35:19.688029) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-08 06:35:19.688537) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-08 06:35:19.688818) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-08 06:35:19.716039) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 06:35:19.716440) ========= 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.LuSU6p3Mjl/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.qbG2FDon3I/Listeners TMPDIR=/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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-03-08 06:35:19-- 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% 18.1M=0.001s 2017-03-08 06:35:19 (18.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.109583 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 06:35:19.850374) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 06:35:19.850691) ========= 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.LuSU6p3Mjl/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.qbG2FDon3I/Listeners TMPDIR=/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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.026020 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 06:35:19.899409) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-08 06:35:19.899813) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev becff35a0bed14b536bb0a141b0e9640e9cb063d --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 becff35a0bed14b536bb0a141b0e9640e9cb063d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.LuSU6p3Mjl/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.qbG2FDon3I/Listeners TMPDIR=/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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-03-08 06:35:20,007 truncating revision to first 12 chars 2017-03-08 06:35:20,007 Setting DEBUG logging. 2017-03-08 06:35:20,007 attempt 1/10 2017-03-08 06:35:20,007 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/becff35a0bed?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-08 06:35:22,139 unpacking tar archive at: mozilla-central-becff35a0bed/testing/mozharness/ program finished with exit code 0 elapsedTime=2.406890 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-08 06:35:22.330291) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-08 06:35:22.330619) ========= script_repo_revision: becff35a0bed14b536bb0a141b0e9640e9cb063d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-08 06:35:22.330994) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-08 06:35:22.331276) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-08 06:35:22.351152) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-03-08 06:35:22.351544) ========= /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.LuSU6p3Mjl/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.qbG2FDon3I/Listeners TMPDIR=/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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 06:35:22 INFO - MultiFileLogger online at 20170308 06:35:22 in /builds/slave/test 06:35:22 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 06:35:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:35:22 INFO - {'append_to_log': False, 06:35:22 INFO - 'base_work_dir': '/builds/slave/test', 06:35:22 INFO - 'blob_upload_branch': 'Firefox', 06:35:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:35:22 INFO - 'branch': 'Firefox', 06:35:22 INFO - 'buildbot_json_path': 'buildprops.json', 06:35:22 INFO - 'config_files': ('talos/mac_config.py',), 06:35:22 INFO - 'default_actions': ('clobber', 06:35:22 INFO - 'read-buildbot-config', 06:35:22 INFO - 'download-and-extract', 06:35:22 INFO - 'populate-webroot', 06:35:22 INFO - 'create-virtualenv', 06:35:22 INFO - 'install', 06:35:22 INFO - 'run-tests'), 06:35:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:35:22 INFO - 'download_minidump_stackwalk': True, 06:35:22 INFO - 'download_symbols': 'ondemand', 06:35:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:35:22 INFO - 'tooltool.py': '/tools/tooltool.py', 06:35:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:35:22 INFO - '/tools/misc-python/virtualenv.py')}, 06:35:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:35:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:35:22 INFO - 'gecko_profile': False, 06:35:22 INFO - 'gecko_profile_interval': 0, 06:35:22 INFO - 'installer_path': 'installer.exe', 06:35:22 INFO - 'log_level': 'info', 06:35:22 INFO - 'log_name': 'talos', 06:35:22 INFO - 'log_to_console': True, 06:35:22 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:35:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:35:22 INFO - 'opt_config_files': (), 06:35:22 INFO - 'pip_index': False, 06:35:22 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:35:22 INFO - 'cmd': ('bash', 06:35:22 INFO - '-c', 06:35:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:35:22 INFO - 'enabled': True, 06:35:22 INFO - 'halt_on_failure': False, 06:35:22 INFO - 'name': 'check_screen_resolution'},), 06:35:22 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:35:22 INFO - 'cmd': ('bash', 06:35:22 INFO - '-c', 06:35:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:35:22 INFO - 'enabled': True, 06:35:22 INFO - 'halt_on_failure': False, 06:35:22 INFO - 'name': 'check_screen_resolution'},), 06:35:22 INFO - 'run_cmd_checks_enabled': True, 06:35:22 INFO - 'suite': 'dromaeojs-e10s', 06:35:22 INFO - 'system_bits': '32', 06:35:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:35:22 INFO - 'title': 't-yosemite-r7-0341', 06:35:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:35:22 INFO - 'use_talos_json': True, 06:35:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:35:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:35:22 INFO - 'work_dir': 'build'} 06:35:22 INFO - [mozharness: 2017-03-08 14:35:22.568350Z] Running clobber step. 06:35:22 INFO - Running pre-action listener: _resource_record_pre_action 06:35:22 INFO - Running main action method: clobber 06:35:22 INFO - rmtree: /builds/slave/test/build 06:35:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:35:24 INFO - Running post-action listener: _resource_record_post_action 06:35:24 INFO - [mozharness: 2017-03-08 14:35:24.952655Z] Finished clobber step (success) 06:35:24 INFO - [mozharness: 2017-03-08 14:35:24.952913Z] Running read-buildbot-config step. 06:35:24 INFO - Running pre-action listener: _resource_record_pre_action 06:35:24 INFO - Running main action method: read_buildbot_config 06:35:24 INFO - Using buildbot properties: 06:35:24 INFO - { 06:35:24 INFO - "project": "", 06:35:24 INFO - "product": "firefox", 06:35:24 INFO - "script_repo_revision": "production", 06:35:24 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 06:35:24 INFO - "repository": "", 06:35:24 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 06:35:24 INFO - "buildid": "20170308051923", 06:35:24 INFO - "pgo_build": "False", 06:35:24 INFO - "basedir": "/builds/slave/test", 06:35:24 INFO - "buildnumber": 76, 06:35:24 INFO - "slavename": "t-yosemite-r7-0341", 06:35:24 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 06:35:24 INFO - "platform": "yosemite_r7", 06:35:24 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 06:35:24 INFO - "branch": "mozilla-central", 06:35:24 INFO - "repo_path": "mozilla-central", 06:35:24 INFO - "revision": "becff35a0bed14b536bb0a141b0e9640e9cb063d", 06:35:24 INFO - "stage_platform": "macosx64", 06:35:24 INFO - "builduid": "7462c4e2ace840a7b4b9360d7dd28a7b", 06:35:24 INFO - "slavebuilddir": "test" 06:35:24 INFO - } 06:35:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/FWg_Z5jlQoe2ZyCzF7Jyxg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 06:35:24 INFO - Running post-action listener: _resource_record_post_action 06:35:24 INFO - [mozharness: 2017-03-08 14:35:24.958775Z] Finished read-buildbot-config step (success) 06:35:24 INFO - [mozharness: 2017-03-08 14:35:24.958993Z] Running download-and-extract step. 06:35:24 INFO - Running pre-action listener: _resource_record_pre_action 06:35:24 INFO - Running main action method: download_and_extract 06:35:24 INFO - mkdir: /builds/slave/test/build/tests 06:35:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:35:24 INFO - trying https://queue.taskcluster.net/v1/task/FWg_Z5jlQoe2ZyCzF7Jyxg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 06:35:24 INFO - Downloading https://queue.taskcluster.net/v1/task/FWg_Z5jlQoe2ZyCzF7Jyxg/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 06:35:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FWg_Z5jlQoe2ZyCzF7Jyxg/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 06:35:25 INFO - Downloaded 1199 bytes. 06:35:25 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 06:35:25 INFO - Using the following test package requirements: 06:35:25 INFO - {u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 06:35:25 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 06:35:25 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 06:35:25 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 06:35:25 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 06:35:25 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 06:35:25 INFO - u'jsshell-mac.zip'], 06:35:25 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 06:35:25 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 06:35:25 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 06:35:25 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 06:35:25 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 06:35:25 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 06:35:25 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 06:35:25 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 06:35:25 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 06:35:25 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 06:35:25 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 06:35:25 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:35:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FWg_Z5jlQoe2ZyCzF7Jyxg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 06:35:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FWg_Z5jlQoe2ZyCzF7Jyxg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:35:25 INFO - Fetch https://queue.taskcluster.net/v1/task/FWg_Z5jlQoe2ZyCzF7Jyxg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 06:35:27 INFO - Expected file size: 51785998 06:35:27 INFO - Obtained file size: 51785998 06:35:43 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 06:35:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FWg_Z5jlQoe2ZyCzF7Jyxg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 06:35:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FWg_Z5jlQoe2ZyCzF7Jyxg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:35:43 INFO - Fetch https://queue.taskcluster.net/v1/task/FWg_Z5jlQoe2ZyCzF7Jyxg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 06:35:45 INFO - Expected file size: 51785998 06:35:45 INFO - Obtained file size: 51785998 06:36:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FWg_Z5jlQoe2ZyCzF7Jyxg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 06:36:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FWg_Z5jlQoe2ZyCzF7Jyxg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 06:36:00 INFO - Fetch https://queue.taskcluster.net/v1/task/FWg_Z5jlQoe2ZyCzF7Jyxg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 06:36:01 INFO - Expected file size: 14404424 06:36:01 INFO - Obtained file size: 14404424 06:36:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:36:01 INFO - trying https://queue.taskcluster.net/v1/task/FWg_Z5jlQoe2ZyCzF7Jyxg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 06:36:01 INFO - Downloading https://queue.taskcluster.net/v1/task/FWg_Z5jlQoe2ZyCzF7Jyxg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 06:36:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FWg_Z5jlQoe2ZyCzF7Jyxg/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 06:36:04 INFO - Downloaded 74926864 bytes. 06:36:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FWg_Z5jlQoe2ZyCzF7Jyxg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 06:36:04 INFO - mkdir: /builds/slave/test/properties 06:36:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:36:04 INFO - Writing to file /builds/slave/test/properties/build_url 06:36:04 INFO - Contents: 06:36:04 INFO - build_url:https://queue.taskcluster.net/v1/task/FWg_Z5jlQoe2ZyCzF7Jyxg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 06:36:04 INFO - Running post-action listener: _resource_record_post_action 06:36:04 INFO - Running post-action listener: set_extra_try_arguments 06:36:04 INFO - [mozharness: 2017-03-08 14:36:04.794734Z] Finished download-and-extract step (success) 06:36:04 INFO - [mozharness: 2017-03-08 14:36:04.794861Z] Running populate-webroot step. 06:36:04 INFO - Running pre-action listener: _resource_record_pre_action 06:36:04 INFO - Running main action method: populate_webroot 06:36:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:36:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:36:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:36:04 INFO - '--tppagecycles', 06:36:04 INFO - '7'], 06:36:04 INFO - 'tests': ['tsvgm']}}, 06:36:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:36:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:36:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:36:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:36:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:36:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:36:04 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 06:36:04 INFO - 'talos_options': ['--disable-e10s'], 06:36:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:36:04 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:36:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:36:04 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 06:36:04 INFO - 'talos_options': ['--disable-e10s'], 06:36:04 INFO - 'tests': ['damp', 'tps']}, 06:36:04 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:36:04 INFO - 'tests': ['damp', 'tps']}, 06:36:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:36:04 INFO - 'tests': ['dromaeo_dom']}, 06:36:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:36:04 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:36:04 INFO - 'tests': ['basic_compositor_video']}, 06:36:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:36:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:36:04 INFO - 'tests': ['a11yr', 06:36:04 INFO - 'ts_paint', 06:36:04 INFO - 'tpaint', 06:36:04 INFO - 'sessionrestore', 06:36:04 INFO - 'sessionrestore_no_auto_restore', 06:36:04 INFO - 'tabpaint']}, 06:36:04 INFO - 'other-e10s': {'tests': ['a11yr', 06:36:04 INFO - 'ts_paint', 06:36:04 INFO - 'tpaint', 06:36:04 INFO - 'sessionrestore', 06:36:04 INFO - 'sessionrestore_no_auto_restore', 06:36:04 INFO - 'tabpaint']}, 06:36:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:36:04 INFO - 'ts_paint', 06:36:04 INFO - 'tpaint', 06:36:04 INFO - 'sessionrestore', 06:36:04 INFO - 'sessionrestore_no_auto_restore', 06:36:04 INFO - 'tabpaint']}, 06:36:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:36:04 INFO - 'ts_paint', 06:36:04 INFO - 'tpaint', 06:36:04 INFO - 'sessionrestore', 06:36:04 INFO - 'sessionrestore_no_auto_restore', 06:36:04 INFO - 'tabpaint']}, 06:36:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:36:04 INFO - 'tests': ['a11yr', 06:36:04 INFO - 'ts_paint', 06:36:04 INFO - 'tpaint', 06:36:04 INFO - 'sessionrestore', 06:36:04 INFO - 'sessionrestore_no_auto_restore', 06:36:04 INFO - 'tabpaint']}, 06:36:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:36:04 INFO - 'tests': ['a11yr', 06:36:04 INFO - 'ts_paint', 06:36:04 INFO - 'tpaint', 06:36:04 INFO - 'sessionrestore', 06:36:04 INFO - 'sessionrestore_no_auto_restore', 06:36:04 INFO - 'tabpaint']}, 06:36:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:36:04 INFO - 'tests': ['tsvgx', 06:36:04 INFO - 'tsvgr_opacity', 06:36:04 INFO - 'tart', 06:36:04 INFO - 'tscrollx', 06:36:04 INFO - 'cart', 06:36:04 INFO - 'tsvg_static']}, 06:36:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:36:04 INFO - 'tsvgr_opacity', 06:36:04 INFO - 'tart', 06:36:04 INFO - 'tscrollx', 06:36:04 INFO - 'cart', 06:36:04 INFO - 'tsvg_static']}, 06:36:04 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 06:36:04 INFO - 'talos_options': ['--disable-e10s'], 06:36:04 INFO - 'tests': ['tp5o']}, 06:36:04 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:36:04 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 06:36:04 INFO - 'talos_options': ['--disable-e10s', 06:36:04 INFO - '--xperf_path', 06:36:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:36:04 INFO - 'tests': ['tp5n']}, 06:36:04 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:36:04 INFO - 'talos_options': ['--xperf_path', 06:36:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:36:04 INFO - 'tests': ['tp5n']}}, 06:36:04 INFO - 'talos.zip': {'path': '', 06:36:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:36:04 INFO - Running post-action listener: _resource_record_post_action 06:36:04 INFO - [mozharness: 2017-03-08 14:36:04.814122Z] Finished populate-webroot step (success) 06:36:04 INFO - [mozharness: 2017-03-08 14:36:04.814217Z] Running create-virtualenv step. 06:36:04 INFO - Running pre-action listener: _resource_record_pre_action 06:36:04 INFO - Running main action method: create_virtualenv 06:36:04 INFO - Creating virtualenv /builds/slave/test/build/venv 06:36:04 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 06:36:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:36:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:36:04 INFO - Using real prefix '/tools/python27' 06:36:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:36:05 INFO - Installing distribute.............................................................................................................................................................................................done. 06:36:08 INFO - Installing pip.................done. 06:36:08 INFO - Return code: 0 06:36:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:36:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:36:08 INFO - Reading from file tmpfile_stdout 06:36:08 INFO - Output received: 06:36:08 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) 06:36:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:36:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:36:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:36:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:08 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 0x10d968b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d96b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb7a59dbc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d746d30>, '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 0x10d66ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d73bbe8>, '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.LuSU6p3Mjl/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.qbG2FDon3I/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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 06:36:08 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 06:36:08 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 06:36:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LuSU6p3Mjl/Render', 06:36:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:36:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:36:08 INFO - 'HOME': '/Users/cltbld', 06:36:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:36:08 INFO - 'LOGNAME': 'cltbld', 06:36:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:08 INFO - 'MOZ_NO_REMOTE': '1', 06:36:08 INFO - 'NO_EM_RESTART': '1', 06:36:08 INFO - 'PAGER': '/bin/cat', 06:36:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:36:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:08 INFO - 'PWD': '/builds/slave/test', 06:36:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:36:08 INFO - 'SHELL': '/bin/bash', 06:36:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qbG2FDon3I/Listeners', 06:36:08 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 06:36:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:36:08 INFO - 'USER': 'cltbld', 06:36:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:36:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:36:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:08 INFO - 'XPC_FLAGS': '0x0', 06:36:08 INFO - 'XPC_SERVICE_NAME': '0', 06:36:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:36:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:09 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 06:36:09 INFO - Cleaning up... 06:36:09 INFO - Return code: 0 06:36:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:36:09 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')]} 06:36:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:09 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')]} 06:36:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:09 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 0x10d968b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d96b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb7a59dbc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d746d30>, '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 0x10d66ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d73bbe8>, '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.LuSU6p3Mjl/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.qbG2FDon3I/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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 06:36:09 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 06:36:09 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 06:36:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LuSU6p3Mjl/Render', 06:36:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:36:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:36:09 INFO - 'HOME': '/Users/cltbld', 06:36:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:36:09 INFO - 'LOGNAME': 'cltbld', 06:36:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:09 INFO - 'MOZ_NO_REMOTE': '1', 06:36:09 INFO - 'NO_EM_RESTART': '1', 06:36:09 INFO - 'PAGER': '/bin/cat', 06:36:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:36:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:09 INFO - 'PWD': '/builds/slave/test', 06:36:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:36:09 INFO - 'SHELL': '/bin/bash', 06:36:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qbG2FDon3I/Listeners', 06:36:09 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 06:36:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:36:09 INFO - 'USER': 'cltbld', 06:36:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:36:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:36:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:09 INFO - 'XPC_FLAGS': '0x0', 06:36:09 INFO - 'XPC_SERVICE_NAME': '0', 06:36:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:36:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:09 INFO - Downloading/unpacking psutil>=3.1.1 06:36:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:36:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:36:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:36:12 INFO - Installing collected packages: psutil 06:36:12 INFO - Running setup.py install for psutil 06:36:12 INFO - building 'psutil._psutil_osx' extension 06:36:12 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 06:36:13 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 06:36:13 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 06:36:13 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 06:36:13 INFO - building 'psutil._psutil_posix' extension 06:36:13 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 06:36:13 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:36:13 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:36:13 INFO - ^ 06:36:13 INFO - 1 warning generated. 06:36:13 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 06:36:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:36:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:36:13 INFO - Successfully installed psutil 06:36:13 INFO - Cleaning up... 06:36:14 INFO - Return code: 0 06:36:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:36:14 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')]} 06:36:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:14 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')]} 06:36:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:14 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 0x10d968b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d96b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb7a59dbc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d746d30>, '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 0x10d66ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d73bbe8>, '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.LuSU6p3Mjl/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.qbG2FDon3I/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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 06:36:14 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 06:36:14 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 06:36:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LuSU6p3Mjl/Render', 06:36:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:36:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:36:14 INFO - 'HOME': '/Users/cltbld', 06:36:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:36:14 INFO - 'LOGNAME': 'cltbld', 06:36:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:14 INFO - 'MOZ_NO_REMOTE': '1', 06:36:14 INFO - 'NO_EM_RESTART': '1', 06:36:14 INFO - 'PAGER': '/bin/cat', 06:36:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:36:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:14 INFO - 'PWD': '/builds/slave/test', 06:36:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:36:14 INFO - 'SHELL': '/bin/bash', 06:36:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qbG2FDon3I/Listeners', 06:36:14 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 06:36:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:36:14 INFO - 'USER': 'cltbld', 06:36:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:36:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:36:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:14 INFO - 'XPC_FLAGS': '0x0', 06:36:14 INFO - 'XPC_SERVICE_NAME': '0', 06:36:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:36:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:36: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 06:36: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 06:36: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 06:36: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 06:36: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 06:36: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 06:36:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:36:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:36:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:36:17 INFO - Installing collected packages: mozsystemmonitor 06:36:17 INFO - Running setup.py install for mozsystemmonitor 06:36:17 INFO - Successfully installed mozsystemmonitor 06:36:17 INFO - Cleaning up... 06:36:17 INFO - Return code: 0 06:36:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:36:17 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')]} 06:36:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:17 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')]} 06:36:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:18 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 0x10d968b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d96b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb7a59dbc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d746d30>, '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 0x10d66ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d73bbe8>, '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.LuSU6p3Mjl/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.qbG2FDon3I/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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 06:36:18 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 06:36:18 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 06:36:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LuSU6p3Mjl/Render', 06:36:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:36:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:36:18 INFO - 'HOME': '/Users/cltbld', 06:36:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:36:18 INFO - 'LOGNAME': 'cltbld', 06:36:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:18 INFO - 'MOZ_NO_REMOTE': '1', 06:36:18 INFO - 'NO_EM_RESTART': '1', 06:36:18 INFO - 'PAGER': '/bin/cat', 06:36:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:36:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:18 INFO - 'PWD': '/builds/slave/test', 06:36:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:36:18 INFO - 'SHELL': '/bin/bash', 06:36:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qbG2FDon3I/Listeners', 06:36:18 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 06:36:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:36:18 INFO - 'USER': 'cltbld', 06:36:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:36:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:36:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:18 INFO - 'XPC_FLAGS': '0x0', 06:36:18 INFO - 'XPC_SERVICE_NAME': '0', 06:36:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:36:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:18 INFO - Downloading/unpacking jsonschema==2.5.1 06:36:18 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 06:36:18 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 06:36:18 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 06:36:18 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 06:36:18 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 06:36:18 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 06:36:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:36:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:36:21 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 06:36:21 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 06:36:21 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 06:36:21 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 06:36:21 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 06:36:21 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 06:36:21 INFO - Downloading functools32-3.2.3-2.tar.gz 06:36:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:36:21 INFO - warning: no files found matching '*.txt' 06:36:21 INFO - no previously-included directories found matching 'build' 06:36:21 INFO - no previously-included directories found matching 'dist' 06:36:21 INFO - no previously-included directories found matching '.git*' 06:36:21 INFO - Installing collected packages: jsonschema, functools32 06:36:21 INFO - Running setup.py install for functools32 06:36:21 INFO - warning: no files found matching '*.txt' 06:36:21 INFO - no previously-included directories found matching 'build' 06:36:21 INFO - no previously-included directories found matching 'dist' 06:36:21 INFO - no previously-included directories found matching '.git*' 06:36:21 INFO - Successfully installed jsonschema functools32 06:36:21 INFO - Cleaning up... 06:36:21 INFO - Return code: 0 06:36:21 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:36:21 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')]} 06:36:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:21 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')]} 06:36:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:21 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 0x10d968b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d96b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb7a59dbc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d746d30>, '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 0x10d66ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d73bbe8>, '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.LuSU6p3Mjl/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.qbG2FDon3I/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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 06:36:21 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 06:36:21 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 06:36:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LuSU6p3Mjl/Render', 06:36:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:36:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:36:21 INFO - 'HOME': '/Users/cltbld', 06:36:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:36:21 INFO - 'LOGNAME': 'cltbld', 06:36:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:21 INFO - 'MOZ_NO_REMOTE': '1', 06:36:21 INFO - 'NO_EM_RESTART': '1', 06:36:21 INFO - 'PAGER': '/bin/cat', 06:36:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:36:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:21 INFO - 'PWD': '/builds/slave/test', 06:36:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:36:21 INFO - 'SHELL': '/bin/bash', 06:36:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qbG2FDon3I/Listeners', 06:36:21 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 06:36:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:36:21 INFO - 'USER': 'cltbld', 06:36:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:36:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:36:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:21 INFO - 'XPC_FLAGS': '0x0', 06:36:21 INFO - 'XPC_SERVICE_NAME': '0', 06:36:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:36:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:22 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:36:22 INFO - Cleaning up... 06:36:22 INFO - Return code: 0 06:36:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:36:22 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')]} 06:36:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:22 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')]} 06:36:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:22 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 0x10d968b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d96b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb7a59dbc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d746d30>, '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 0x10d66ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d73bbe8>, '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.LuSU6p3Mjl/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.qbG2FDon3I/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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 06:36:22 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 06:36:22 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 06:36:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LuSU6p3Mjl/Render', 06:36:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:36:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:36:22 INFO - 'HOME': '/Users/cltbld', 06:36:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:36:22 INFO - 'LOGNAME': 'cltbld', 06:36:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:22 INFO - 'MOZ_NO_REMOTE': '1', 06:36:22 INFO - 'NO_EM_RESTART': '1', 06:36:22 INFO - 'PAGER': '/bin/cat', 06:36:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:36:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:22 INFO - 'PWD': '/builds/slave/test', 06:36:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:36:22 INFO - 'SHELL': '/bin/bash', 06:36:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qbG2FDon3I/Listeners', 06:36:22 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 06:36:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:36:22 INFO - 'USER': 'cltbld', 06:36:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:36:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:36:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:22 INFO - 'XPC_FLAGS': '0x0', 06:36:22 INFO - 'XPC_SERVICE_NAME': '0', 06:36:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:36:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:22 INFO - Downloading/unpacking blobuploader==1.2.4 06:36: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 06:36: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 06:36: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 06:36: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 06:36: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 06:36: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 06:36:25 INFO - Downloading blobuploader-1.2.4.tar.gz 06:36:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:36:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:36:25 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 06:36:25 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 06:36:25 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 06:36:25 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 06:36:25 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 06:36:25 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 06:36:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:36:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:36:25 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 06:36:25 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 06:36:25 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 06:36:25 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 06:36:25 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 06:36:25 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 06:36:26 INFO - Downloading docopt-0.6.1.tar.gz 06:36:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:36:26 INFO - Installing collected packages: blobuploader, requests, docopt 06:36:26 INFO - Running setup.py install for blobuploader 06:36:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:36:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:36:26 INFO - Running setup.py install for requests 06:36:27 INFO - Running setup.py install for docopt 06:36:27 INFO - Successfully installed blobuploader requests docopt 06:36:27 INFO - Cleaning up... 06:36:27 INFO - Return code: 0 06:36:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:36:27 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')]} 06:36:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:27 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')]} 06:36:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:27 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 0x10d968b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d96b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb7a59dbc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d746d30>, '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 0x10d66ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d73bbe8>, '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.LuSU6p3Mjl/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.qbG2FDon3I/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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 06:36:27 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 06:36:27 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 06:36:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LuSU6p3Mjl/Render', 06:36:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:36:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:36:27 INFO - 'HOME': '/Users/cltbld', 06:36:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:36:27 INFO - 'LOGNAME': 'cltbld', 06:36:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:27 INFO - 'MOZ_NO_REMOTE': '1', 06:36:27 INFO - 'NO_EM_RESTART': '1', 06:36:27 INFO - 'PAGER': '/bin/cat', 06:36:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:36:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:27 INFO - 'PWD': '/builds/slave/test', 06:36:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:36:27 INFO - 'SHELL': '/bin/bash', 06:36:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qbG2FDon3I/Listeners', 06:36:27 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 06:36:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:36:27 INFO - 'USER': 'cltbld', 06:36:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:36:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:36:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:27 INFO - 'XPC_FLAGS': '0x0', 06:36:27 INFO - 'XPC_SERVICE_NAME': '0', 06:36:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:36:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:36:27 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-A4fIMS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:36:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:36:27 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-aIEvCi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:36:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:36:27 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-WvF5gr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:36:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:36:27 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-JPke3v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:36:28 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-nkwAmH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:36:28 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-5dYewE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:36:28 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-GuKq7g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:36:28 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-3bS_VE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:36:28 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-OOxYq2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:36:28 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-sGdQuc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:36:28 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-sJlNEY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:36:28 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-WZsZxa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:36:28 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-Zn8V80-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:36:28 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-pQKoos-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:36:29 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-UZTz6P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:36:29 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-pNcpl5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:36:29 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-q0h8gq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:36:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:36:29 INFO - Running setup.py install for manifestparser 06:36:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:36:29 INFO - Running setup.py install for mozcrash 06:36:29 INFO - Running setup.py install for mozdebug 06:36:29 INFO - Running setup.py install for mozdevice 06:36:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:36:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:36:30 INFO - Running setup.py install for mozfile 06:36:30 INFO - Running setup.py install for mozhttpd 06:36:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:36:30 INFO - Running setup.py install for mozinfo 06:36:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:36:30 INFO - Running setup.py install for mozInstall 06:36:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:36:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:36:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:36:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:36:30 INFO - Running setup.py install for mozleak 06:36:30 INFO - Running setup.py install for mozlog 06:36:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:36:30 INFO - Running setup.py install for moznetwork 06:36:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:36:31 INFO - Running setup.py install for mozprocess 06:36:31 INFO - Running setup.py install for mozprofile 06:36:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:36:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:36:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:36:31 INFO - Running setup.py install for mozrunner 06:36:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:36:31 INFO - Running setup.py install for mozscreenshot 06:36:31 INFO - Running setup.py install for moztest 06:36:31 INFO - Running setup.py install for mozversion 06:36:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:36:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:36:31 INFO - Cleaning up... 06:36:31 INFO - Return code: 0 06:36:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:36:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:36:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:36:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:31 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 0x10d968b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d96b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb7a59dbc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d746d30>, '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 0x10d66ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d73bbe8>, '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.LuSU6p3Mjl/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.qbG2FDon3I/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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 06:36:31 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 06:36:31 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 06:36:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LuSU6p3Mjl/Render', 06:36:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:36:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:36:31 INFO - 'HOME': '/Users/cltbld', 06:36:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:36:31 INFO - 'LOGNAME': 'cltbld', 06:36:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:31 INFO - 'MOZ_NO_REMOTE': '1', 06:36:31 INFO - 'NO_EM_RESTART': '1', 06:36:31 INFO - 'PAGER': '/bin/cat', 06:36:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:36:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:31 INFO - 'PWD': '/builds/slave/test', 06:36:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:36:31 INFO - 'SHELL': '/bin/bash', 06:36:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qbG2FDon3I/Listeners', 06:36:31 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 06:36:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:36:31 INFO - 'USER': 'cltbld', 06:36:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:36:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:36:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:31 INFO - 'XPC_FLAGS': '0x0', 06:36:31 INFO - 'XPC_SERVICE_NAME': '0', 06:36:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:36:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:36:32 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-pAaZeM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:36:32 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)) 06:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:36:32 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-SvTVrb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:36:32 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)) 06:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:36:32 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-ZneZoY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:36:32 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)) 06:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:36:32 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-4cpCTX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:36:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:36:32 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-zqIgso-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:36:32 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)) 06:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:36:32 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-XcHiXs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:36:32 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)) 06:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:36:32 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-BEnsHs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:36:32 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)) 06:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:36:32 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-Hsj9gI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:36:33 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)) 06:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:36:33 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-9FjVMu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:36:33 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)) 06:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:36:33 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-Pqi9Ww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:36:33 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)) 06:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:36:33 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-g9nDtF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:36:33 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)) 06:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:36:33 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-gMlUNj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:36:33 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)) 06:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:36:33 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-AxzkgP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:36:33 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)) 06:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:36:33 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-bwq9fx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:36:33 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)) 06:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:36:33 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-qFBb21-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:36:33 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)) 06:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:36:33 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-PssIPE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:36:33 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)) 06:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:36:33 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-b0QGk0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:36:34 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)) 06:36:34 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)) 06:36:34 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)) 06:36:34 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)) 06:36:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:36:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:36:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:36:34 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 06:36:34 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 06:36:34 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 06:36:34 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 06:36:34 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 06:36:34 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 06:36:36 INFO - Downloading blessings-1.6.tar.gz 06:36:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:36:36 INFO - Installing collected packages: blessings 06:36:36 INFO - Running setup.py install for blessings 06:36:36 INFO - Successfully installed blessings 06:36:36 INFO - Cleaning up... 06:36:36 INFO - Return code: 0 06:36:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:36:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:36:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:36:37 INFO - Reading from file tmpfile_stdout 06:36:37 INFO - Current package versions: 06:36:37 INFO - blessings == 1.6 06:36:37 INFO - blobuploader == 1.2.4 06:36:37 INFO - docopt == 0.6.1 06:36:37 INFO - functools32 == 3.2.3-2 06:36:37 INFO - jsonschema == 2.5.1 06:36:37 INFO - manifestparser == 1.1 06:36:37 INFO - mozInstall == 1.12 06:36:37 INFO - mozcrash == 1.0 06:36:37 INFO - mozdebug == 0.1 06:36:37 INFO - mozdevice == 0.49 06:36:37 INFO - mozfile == 1.2 06:36:37 INFO - mozhttpd == 0.7 06:36:37 INFO - mozinfo == 0.9 06:36:37 INFO - mozleak == 0.1 06:36:37 INFO - mozlog == 3.4 06:36:37 INFO - moznetwork == 0.27 06:36:37 INFO - mozprocess == 0.25 06:36:37 INFO - mozprofile == 0.28 06:36:37 INFO - mozrunner == 6.13 06:36:37 INFO - mozscreenshot == 0.1 06:36:37 INFO - mozsystemmonitor == 0.3 06:36:37 INFO - moztest == 0.8 06:36:37 INFO - mozversion == 1.4 06:36:37 INFO - psutil == 3.1.1 06:36:37 INFO - requests == 1.2.3 06:36:37 INFO - wsgiref == 0.1.2 06:36:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:36:37 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')]} 06:36:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:37 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')]} 06:36:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:37 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 0x10d968b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d96b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb7a59dbc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d746d30>, '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 0x10d66ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d73bbe8>, '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.LuSU6p3Mjl/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.qbG2FDon3I/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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 06:36:37 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 06:36:37 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 06:36:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LuSU6p3Mjl/Render', 06:36:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:36:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:36:37 INFO - 'HOME': '/Users/cltbld', 06:36:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:36:37 INFO - 'LOGNAME': 'cltbld', 06:36:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:37 INFO - 'MOZ_NO_REMOTE': '1', 06:36:37 INFO - 'NO_EM_RESTART': '1', 06:36:37 INFO - 'PAGER': '/bin/cat', 06:36:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:36:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:37 INFO - 'PWD': '/builds/slave/test', 06:36:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:36:37 INFO - 'SHELL': '/bin/bash', 06:36:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qbG2FDon3I/Listeners', 06:36:37 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 06:36:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:36:37 INFO - 'USER': 'cltbld', 06:36:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:36:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:36:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:37 INFO - 'XPC_FLAGS': '0x0', 06:36:37 INFO - 'XPC_SERVICE_NAME': '0', 06:36:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:36:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:37 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)) 06:36:37 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)) 06:36:37 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)) 06:36:37 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)) 06:36:37 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)) 06:36:37 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)) 06:36:37 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)) 06:36:37 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)) 06:36:37 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)) 06:36:37 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)) 06:36:37 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)) 06:36:37 INFO - Cleaning up... 06:36:37 INFO - Return code: 0 06:36:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:36:37 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')]} 06:36:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:37 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')]} 06:36:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:37 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 0x10d968b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d96b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb7a59dbc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d746d30>, '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 0x10d66ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d73bbe8>, '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.LuSU6p3Mjl/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.qbG2FDon3I/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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 06:36:37 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 06:36:37 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 06:36:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LuSU6p3Mjl/Render', 06:36:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:36:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:36:37 INFO - 'HOME': '/Users/cltbld', 06:36:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:36:37 INFO - 'LOGNAME': 'cltbld', 06:36:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:37 INFO - 'MOZ_NO_REMOTE': '1', 06:36:37 INFO - 'NO_EM_RESTART': '1', 06:36:37 INFO - 'PAGER': '/bin/cat', 06:36:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:36:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:37 INFO - 'PWD': '/builds/slave/test', 06:36:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:36:37 INFO - 'SHELL': '/bin/bash', 06:36:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qbG2FDon3I/Listeners', 06:36:37 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 06:36:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:36:37 INFO - 'USER': 'cltbld', 06:36:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:36:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:36:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:37 INFO - 'XPC_FLAGS': '0x0', 06:36:37 INFO - 'XPC_SERVICE_NAME': '0', 06:36:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:36:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:36:37 INFO - Cleaning up... 06:36:37 INFO - Return code: 0 06:36:37 INFO - Running post-action listener: _resource_record_post_action 06:36:37 INFO - Running post-action listener: _start_resource_monitoring 06:36:37 INFO - Starting resource monitoring. 06:36:37 INFO - [mozharness: 2017-03-08 14:36:37.806577Z] Finished create-virtualenv step (success) 06:36:37 INFO - [mozharness: 2017-03-08 14:36:37.807526Z] Running install step. 06:36:37 INFO - Running pre-action listener: _resource_record_pre_action 06:36:37 INFO - Running main action method: install 06:36:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:36:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:36:38 INFO - Reading from file tmpfile_stdout 06:36:38 INFO - Detecting whether we're running mozinstall >=1.0... 06:36:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:36:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:36:38 INFO - Reading from file tmpfile_stdout 06:36:38 INFO - Output received: 06:36:38 INFO - Usage: mozinstall [options] installer 06:36:38 INFO - Options: 06:36:38 INFO - -h, --help show this help message and exit 06:36:38 INFO - -d DEST, --destination=DEST 06:36:38 INFO - Directory to install application into. [default: 06:36:38 INFO - "/builds/slave/test"] 06:36:38 INFO - --app=APP Application being installed. [default: firefox] 06:36:38 INFO - mkdir: /builds/slave/test/build/application 06:36:38 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'] 06:36:38 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 06:36:58 INFO - Reading from file tmpfile_stdout 06:36:58 INFO - Output received: 06:36:58 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 06:36:58 INFO - Running post-action listener: _resource_record_post_action 06:36:58 INFO - [mozharness: 2017-03-08 14:36:58.456910Z] Finished install step (success) 06:36:58 INFO - [mozharness: 2017-03-08 14:36:58.457013Z] Running run-tests step. 06:36:58 INFO - Running pre-action listener: _resource_record_pre_action 06:36:58 INFO - Running main action method: run_tests 06:36:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:36:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:36:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:36:58 INFO - 2017-03-08 06:36:58.471 screenresolution[1621:7456] starting screenresolution argv=screenresolution get 06:36:58 INFO - 2017-03-08 06:36:58.474 screenresolution[1621:7456] Display 0: 1600x1200x32@60 06:36:58 INFO - 2017-03-08 06:36:58.480 screenresolution[1622:7459] starting screenresolution argv=screenresolution list 06:36:58 INFO - Available Modes on Display 0 06:36:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:36:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:36:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:36:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:36:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:36:58 INFO - Intel Iris: 06:36:58 INFO - Chipset Model: Intel Iris 06:36:58 INFO - Type: GPU 06:36:58 INFO - Bus: Built-In 06:36:58 INFO - VRAM (Dynamic, Max): 1536 MB 06:36:58 INFO - Vendor: Intel (0x8086) 06:36:58 INFO - Device ID: 0x0a2e 06:36:58 INFO - Revision ID: 0x0009 06:36:58 INFO - Displays: 06:36:58 INFO - Display: 06:36:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:36:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:36:58 INFO - Display Serial Number: 1600x1200 60 06:36:58 INFO - Main Display: Yes 06:36:58 INFO - Mirror: Off 06:36:58 INFO - Online: Yes 06:36:58 INFO - Rotation: Supported 06:36:58 INFO - Return code: 0 06:36:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:36:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:36:58 INFO - Python 2.7.3 06:36:58 INFO - Return code: 0 06:36:58 INFO - grabbing minidump binary from tooltool 06:36:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:36:58 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 0x10d746d30>, '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 0x10d66ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d73bbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:36:58 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 06:36:58 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 06:36:58 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 06:36:58 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:36:58 INFO - Return code: 0 06:36:58 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:36:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:36:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:36:58 INFO - ENV: RUST_BACKTRACE is now 1 06:36:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:36:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:36:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FWg_Z5jlQoe2ZyCzF7Jyxg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0341', '--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 06:36:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FWg_Z5jlQoe2ZyCzF7Jyxg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0341 --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 06:36:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LuSU6p3Mjl/Render', 06:36:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:36:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:36:58 INFO - 'HOME': '/Users/cltbld', 06:36:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:36:58 INFO - 'LOGNAME': 'cltbld', 06:36:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:36:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:36:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:58 INFO - 'MOZ_NO_REMOTE': '1', 06:36:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:36:58 INFO - 'NO_EM_RESTART': '1', 06:36:58 INFO - 'PAGER': '/bin/cat', 06:36:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:36:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:58 INFO - 'PWD': '/builds/slave/test', 06:36:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:36:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:36:58 INFO - 'RUST_BACKTRACE': '1', 06:36:58 INFO - 'SHELL': '/bin/bash', 06:36:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qbG2FDon3I/Listeners', 06:36:58 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 06:36:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:36:58 INFO - 'USER': 'cltbld', 06:36:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:36:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:36:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:58 INFO - 'XPC_FLAGS': '0x0', 06:36:58 INFO - 'XPC_SERVICE_NAME': '0', 06:36:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:36:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FWg_Z5jlQoe2ZyCzF7Jyxg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0341', '--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 06:36:59 INFO - mozversion application_buildid: 20170308051923 06:36:59 INFO - mozversion application_changeset: becff35a0bed14b536bb0a141b0e9640e9cb063d 06:36:59 INFO - mozversion application_display_name: Nightly 06:36:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:36:59 INFO - mozversion application_name: Firefox 06:36:59 INFO - mozversion application_remotingname: firefox 06:36:59 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:36:59 INFO - mozversion application_vendor: Mozilla 06:36:59 INFO - mozversion application_version: 55.0a1 06:36:59 INFO - mozversion platform_buildid: 20170308051923 06:36:59 INFO - mozversion platform_changeset: becff35a0bed14b536bb0a141b0e9640e9cb063d 06:36:59 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:36:59 INFO - mozversion platform_version: 55.0a1 06:36:59 INFO - using testdate: 1488983819 06:36:59 INFO - actual date: 1488983819 06:36:59 INFO - starting webserver on 'localhost:49241' 06:36:59 INFO - SUITE-START | Running 2 tests 06:36:59 INFO - TEST-START | dromaeo_css 06:36:59 INFO - operating with platform_type : mac_ 06:36:59 INFO - Initialising browser for dromaeo_css test... 06:36:59 INFO - TEST-INFO | started process 1632 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/tmpHlBDOR/profile http://localhost:49241/getInfo.html) 06:37:02 INFO - PROCESS | 1632 | 2017-03-08 06:37:02.098 plugin-container[1633:7629] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d3f, name = 'com.apple.tsm.portname' 06:37:02 INFO - PROCESS | 1632 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:37:02 INFO - PROCESS | 1632 | 2017-03-08 06:37:02.104 plugin-container[1633:7629] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4b17, name = 'com.apple.CFPasteboardClient' 06:37:02 INFO - PROCESS | 1632 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:37:02 INFO - PROCESS | 1632 | 2017-03-08 06:37:02.104 plugin-container[1633:7629] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 06:37:02 INFO - PROCESS | 1632 | __metrics Screen width/height:1600/1200 06:37:02 INFO - PROCESS | 1632 | colorDepth:24 06:37:02 INFO - PROCESS | 1632 | Browser inner width/height: 1024/689 06:37:02 INFO - PROCESS | 1632 | __metrics 06:37:02 ERROR - PROCESS | 1632 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3353: TypeError: this.tabs is undefined 06:37:03 INFO - TEST-INFO | 1632: exit 0 06:37:03 INFO - Browser initialized. 06:37:03 INFO - Running cycle 1/1 for dromaeo_css test... 06:37:03 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/tmpHlBDOR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:37:05 INFO - PROCESS | 1635 | 2017-03-08 06:37:05.698 plugin-container[1636:7770] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b4f, name = 'com.apple.tsm.portname' 06:37:05 INFO - PROCESS | 1635 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:37:05 INFO - PROCESS | 1635 | 2017-03-08 06:37:05.701 plugin-container[1636:7770] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4713, name = 'com.apple.CFPasteboardClient' 06:37:05 INFO - PROCESS | 1635 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:37:05 INFO - PROCESS | 1635 | 2017-03-08 06:37:05.701 plugin-container[1636:7770] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 06:37:15 INFO - PROCESS | 1635 | RSS: Main: 226934784 06:37:15 INFO - PROCESS | 1635 | 06:40:19 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 06:40:21 INFO - PROCESS | 1635 | RSS: Main: 249868288 06:40:21 INFO - PROCESS | 1635 | 06:42:03 INFO - PROCESS | 1635 | ************************* 06:42:03 INFO - PROCESS | 1635 | A coding exception was thrown and uncaught in a Task. 06:42:03 INFO - PROCESS | 1635 | 06:42:03 ERROR - PROCESS | 1635 | Full message: TypeError: NetworkError when attempting to fetch resource. 06:42:03 INFO - PROCESS | 1635 | Full stack: 06:42:03 INFO - PROCESS | 1635 | ************************* 06:43:23 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 06:43:24 INFO - PROCESS | 1635 | RSS: Main: 260849664 06:43:24 INFO - PROCESS | 1635 | 06:46:26 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 06:46:27 INFO - PROCESS | 1635 | RSS: Main: 272207872 06:46:27 INFO - PROCESS | 1635 | 06:49:29 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 06:49:29 INFO - PROCESS | 1635 | RSS: Main: 265568256 06:49:29 INFO - PROCESS | 1635 | 06:52:32 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 06:52:33 INFO - PROCESS | 1635 | RSS: Main: 276168704 06:52:33 INFO - PROCESS | 1635 | 06:55:36 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 06:55:36 INFO - PROCESS | 1635 | RSS: Main: 269967360 06:55:36 INFO - PROCESS | 1635 | 06:55:36 INFO - PROCESS | 1635 | __start_tp_report 06:55:36 INFO - PROCESS | 1635 | _x_x_mozilla_page_load 06:55:36 INFO - PROCESS | 1635 | _x_x_mozilla_page_load_details 06:55:36 INFO - PROCESS | 1635 | |i|pagename|runs| 06:55:36 INFO - PROCESS | 1635 | |0;dojo.html;3016.834074125923;3442.50083737858;3465.4975028620865;3466.01218652684;3489.057954352325;5798;5945.108233764938;5958.374370691075;5960.344362120163;6064.272287325516;5827.504662103726;5871.794487192949;5900.734466948987;5932.970335148329;6060.151578778975;5219.903820197763;5296.973515132419;5377.542908852753;5395.59533035022;5452.2094296327;4600.769961501928;5329.094054010808;5399.055165346068;5448.891022179554;5477.698726570037;5400.459954004587;5421.647592906448;5460.099083651193;5463.3717122530825;5471;5191.844244672666;5283.1546952487415;5285.973570132125;5321.600879933982;5325.973370133163;5323.760430780585;5334.893302133935;5341.973290133564;5360.865978350534;5403.405625381244;4240.809163587646;5800.651960882318;5908.291005079375;5911.497522710575;5987.311459182206;6241.7191226394925;6249.343818899041;6325.430711236011;6333.55665103443;6366.87266254677;5528.198411230389;5985.790497332572;6296.464800491964;6394;6427.357264273582;6099.451049405575;6106;6114.755409783648;6115.541334399938;6125.540584456139;6279.623222606659;6495.902561461582;6558.311377305315;6585.209774826955;6615.933840661532;6164.167837341902;6216.378362163748;6252.6873656317;6266.310705822356;6292.622442653455;6300.810975670737;6345.428911397997;6347.460465860454;6348.111264422984;6354.142190804275;6231.501479881598;6314.652694101868;6320.652364120017;6327.683615819191;6335.746570137235;5670.950874088307;6263.561550691499;6348.333424990402;6358.141650877073;6449.7420103195345;5030.924536131961;5061;5109.744512774347;5130.692158470503;5157.355330583677;4584.61030812378;4584.701994370355;4601.608863246662;4619.769011549409;4620.792064357112;6142.938570614326;6148.1085242639565;6154.446099851035;6157.107219453154;6157.784477543264;5124.846254612367;6294.992801151885;6363.172787537591;6396.84007899797;6420.1974753155855;6060.636361818305;6080.75676972925;6102.938970610237;6122.204113465221;6124.6325220486915;5638.407967163471;5655.1799989001365;5666.518345940559;5668.95124401987;5669.262995810601;6330;6591.571547849375;6618.338166183343;6634.436072933855;6675.566088204251;6249.531285153723;6309.842253943688;6327.651979141191;6340.651264180515;6380.457661098859;5094.592432605456;6606.075149479173;6634.137562116894;6651.16860392451;6667.066610674412;5784.4960310318775;6296.5592408530965;6311.558190926591;6338.968305158629;6385.074164246251;5687.77248910039;6272.40412160844;6287.245530536365;6316.494680425463;6319.210098737658;6291.591046581958;6299.937000629935;6311.431971122621;6322.589031712924;6328.588641738273;6107.61364822091;6123.618175568305;6305.180326557702;6329.8734025320155;6335.683215839097;5064.5441910228255;5306.681599104066;5787.160861675117;6132.386102851662;6144.03390914903;6214.5960512566535;6247.344028877084;6320.304766475776;6323.430891219812;6354.555181137461;6201.348858369806;6210.347913469202;6211.875762484635;6231.688415579293;6248.843778905563 06:55:36 INFO - PROCESS | 1635 | |1;ext.html;782.0849605961025;800.1398496616138;834.3658819297332;864.8270345930812;935.8642996765474;35635;36402;36403.81798091009;37511.812440937756;37712.43431348525;36117;36381;36387.818060909725;36446.8177659112;36526.45210321847;7532.623368831551;7662.348700360448;7690.461667683265;10161;10432.426216558086;8506.74479765608;10234.334768240078;10325.793484130312;10328.22538309626;10357.585696572129;10366.637167699131;10385.688429347132;10398.688039358794;10403;10421.53103110362;10323.53544090514;10332.896671033306;10346.948265258625;10377.429241391721;10380.636677716318;10158.796824063551;10183.694489165337;10216.233782466345;10232.181425485944;10236.385816851012;31877;32072.518912216336;32083;32133.839330803195;32161.517577236362;3631.074076110575;3661.7253705971893;3666.211764470652;3670.944935825965;3814.275287695357;22714.205002824987;24626.876865615737;24910.252692419257;24928.252152435274;24953.376165595822;2813.8885140369644;2934.105097945126;3025.6520500142547;3073.247054471669;3105.54969529417;310451;346864;347096;351405;351544;36431;36827.81586092053;39423.60576394256;40883;41650.37524437136;43573.782131089145;43625.78187109108;43729.344059839124;43730.562694373286;43805;10393.428361440043;12677.556285529961;12753.744925101631;12820.038497112753;12823.166494177849;9104.499252541174;10915.672529824118;10936.031514327338;10938.398388088572;10952.616658416917;11328.490217940212;11332;11343.489542970587;11423.086153107897;11450.255733377471;5571.860703482445;5581.162825576196;5609.354924183771;5613.905288468791;5629.8592535186945;804.9959750201211;900.3697411811627;906.5875026862761;943.4858002388714;973.425678849468;19437.902810485855;24671.506569868503;26389.208323750318;27343.906243750425;27393.86303068472;1003.6386900715737;1010.4190090697878;1035.6012935020071;1047.4343854318736;1051.206339213904;11857.5849845255;11979.820302695467;13228.338583070808;14111.294435278194;14156;451061;453724;454948;455413.72293138324;455551;51951;52045.47954520482;52363.476365236624;52458.21312680313;52529.737351313;1341.6712905338059;1412.4251459622653;1412.78808178774;1417.7164567086418;1424.4159894443228;25303.493930121662;26289.868550657888;26479;26562;26792.19623411301;42219.36670949877;42329.94175145646;43086.13827723491;44257.893552661444;44519.88700282519;444570;444638;445724.77137614106;445796;447732;22840.65739013883;23304.951277192227;26796.732032679425;27493.17520474389;27621.823490298873;35768.64231357757;36522.634773652986;36562.63437365699;36590.634093659784;36754.897353079454;28275.43449131047;31083.68916310808;31179;31209.8439507801;31524.36951261008;30646.92735754238;30671.85929899524;30753.92361267345;30962.845185773927;31123.221919452193;27725.584116238675;29036.564451533668;30375.392492149593;30865.537016944316;30919;27189.86405067962;27524.44951101007;27535.86232068827;27746.8901243948;28237.858810705817;21668.566628667653;21805.345839624835;21851.344459666234;21875.453113672287;21896.562068758216 06:55:36 INFO - PROCESS | 1635 | |2;jquery.html;391.5986114232909;392.5132835284245;405.1835551364;423.4431722285195;433.78323801736116;16196.757048644251;19562.11970461329;20562.69155962662;20882.686759698598;20888.37334879954;20771;20879.791202087974;21022.73863568187;21338.35984920451;21551.892240538775;5382.273393091941;5423.376311724162;5512.228288039678;6616.0406741022525;6637.303083176269;6377.234731832186;6471.805845824632;6477.54657173998;6489.4483968862705;6595.472362211036;6541.47668186544;6543.607383556978;6549.1158693576235;6569.540132190748;6575.835604109888;6271.310155882872;6581.177352830896;6595.406413422767;6625.569337993015;6630.6021638701595;6452.161219041542;6463.1274777904855;6473.158489396395;6757.662116894136;7088.751893683748;22068.668969965463;22510;24318.635220471708;25639.333443326123;26131.738682613122;2639.838471072722;2852.443773464175;2894.3343031102963;2913.300807806111;2926.283060650133;13694.178349299074;15255;15282.159481228528;15353.385864565404;16470;1732.315735284568;1971;1989.8607097503182;2041.5712700332947;2119.2476670781803;125191;154748;157796.42203578047;158508.41491585167;159043;18641.7203741944;20483.590328193353;20497.59004819925;20776.06507707157;20816.85507297113;31070.53394199089;31091.378172436423;31128;31322;31338;9640.325177237666;9884.950575247221;10088.69733907984;10255.641052563124;10305.639302624371;8272.627731752085;8284.71003514886;8312.709055183039;8415.032271288757;8476.27951624119;9319.90680093204;9676.951615241878;9678.274129440179;9705.029497050238;9896.059874311928;3530.5410296661785;4086.468759061303;4151.61556756325;4201.432806571073;4226.76752778594;997.2769741937037;1004.1565085328214;1004.5680357446369;1011.251673761426;1047.3035431438161;19167.616647666968;20240.49398765013;20264;20293.391198264075;20499.4875128123;826.5908375354118;949.8147861167145;991.6925753016588;1026.373911913732;1033.751899544104;9137.725868223832;9334.626614935327;9784.853227201598;9813.80372392548;10570.630027948984;686343;687206;688793;712833;715280;148526;149791.25104374628;161903;172917;176236;1231.199720181889;1296.6434230586665;1314.0210543145417;1318.3078883586002;1327.7344531093627;19417.611647767248;19507;19558.924259165884;19701.70447443261;19812.603747924673;38517.422238667;57146;58168.4183158163;58691.70654146702;62579;61778;77273;80431;82505;84793;10526.736831579272;10924.071453926505;11357.204995650225;11621.24461909973;11798;12605.054620903285;12792.61622151337;13029.218246905217;13053.412596433373;13164.14433061848;10920.50857711389;10949.616763413242;10980.835287470854;11171.66485005451;11225.4387280634;9505.906820715707;9958;10727.19546034035;10812.783744325227;11143.442827858413;8656.870146947675;10719.785604287714;10977.945110274397;11382.430878455878;11562.364069976233;9270.907290927003;10955.24716045429;11484.82772758426;11759.823602645796;11795.233309834834;10835.67492975212;10870.293430926964;11109.944450277697;11131.554737810397;11249.775004500028 06:55:36 INFO - PROCESS | 1635 | |3;mootools.html;1320.2738493828392;1396.5391420831127;1552.7748476470913;1597.2652579813284;1607.7990251218598;9227.169554740072;9995.450250236234;10564.894351056488;10739.355638661676;10991.835122473169;9567.330286879904;10676.651136749922;10840.566377344916;10990;11050.281731687435;1829.387155302975;2322.8025617822505;2362.456634973957;2368.692070030894;2370.4784947311564;2225.2100504320974;2254.1546919905036;2256.8533045352083;2262.423082114067;2273.6021196290667;2310.688057112285;2331.19573747057;2338.6375111857687;2338.8245881558864;2341.5433990371885;2202.559488102386;2216.567769284982;2223.1774243529835;2224.2215224671318;2226.4322597737637;2254.030766770288;2315.2591170825344;2317.629179331299;2318.501522172724;2323.6630688550067;10923.836142457869;10945.179111566664;10994.670159895137;11016.779664406748;11020.779584408347;5693.316801983747;5803.129530570406;5862.677552734598;5889.352171261158;5909.438603332676;3320.286138480214;3392.050225936717;3611.8261564991485;3614.4759009943673;3618.1135621772833;1141.452102990561;1159.2233203753506;1164.9068074554016;1186.730914738558;1207.927524348542;14944.327505262288;15018.324175412023;15178.316975736008;15201.543953681297;15247.932644714874;4381.277089280233;4601.838935637236;4687.648426368036;4689.906201875943;4696.319033740088;11226.93344132306;11232.438378081064;11243.775124497464;11258.43707814606;11268.887311126784;5575.888482230333;5594.384617692051;5601.719914004365;5614.1859430382365;5617.01702202113;4981.12830254704;5040.36995375578;5120.1039818031695;5168.715720635326;5207.765650545734;3774.7735135891385;3814.5231846019246;3818.7326887118193;3892;3906.824192911326;1023.8003589300015;1028.0747327405395;1036.290141253244;1050.76883085721;1051.75283808305;781.5818537082633;818.1899919080067;870.4907629037084;921.3090182363228;924.306769922558;6341.080543321193;6387.425131738073;6544.70548825304;6613.570117942415;6659.4006539411685;851.3699862102;1073.9677809665723;1080.7514271717391;1102.3385968419045;1104.8508451358964;3553.182767963383;3615.060084378081;4330.7401555906745;4339.761313127745;4586.656000799887;12643.620691379274;12796.360181990864;13396.531121410704;13496.190228586316;13831.446742130403;13079.084464087422;13315;13334.26661533625;13346.065775395824;13365.198088114745;9829.164521015793;9935.701928942288;10062.195024398177;10083.697489075339;10085.638438810813;6383.840403989938;6602.379039058695;6702.597844129173;6738.797836064926;6859.725610975505;11503.884961150281;11950.46222919988;11955.282683039046;12041.578544750892;12141.392930353624;11839.348835814113;12115.575954841539;12340;12410.317432541297;12413.255204687748;9138.954305228432;9157.77105572366;9352.29857760657;9358.362286599682;9370.578323975575;10176.949115254376;10219.693409197736;10279.691609251735;10289.228307876789;10302.896971030494;8876.911230887867;8999.335123002265;9061.773455663397;9070.727878163665;9241.399309044891;8909.643614255358;8915.168070794016;8950.060243674321;9089.909100908906;9096.9538503073;7599.88600171009;7712.691492340244;7764.767056988299;7770;7774.766756997299;4803.615710743063;5663.9716801415725;5666.801661941812;5737.540996720336;5845.386234445322;5075;5869.119632055226;5980.671063091571;6005.969970150121;6053.75784968614 06:55:36 INFO - PROCESS | 1635 | |4;prototype.html;317.73310419247827;367.762792998516;369.48641388470014;385.57586654679847;389.77003567894934;5293.602979776518;5350.849567343021;5367.973160134194;5383.277351247598;5408.6484378515415;3997.7001724870606;4450.799714012869;4492.191405547001;4611.446626404836;5246.554042906358;3686.926261474769;3732.738708290414;3832.846686132565;3866.975251558339;4078.3882417637296;3441.4321636929876;4272.423222864904;4315.158544083889;4325.956740432603;4355.170828252141;3608.600280813256;4305.117450922569;4313.956860431387;4320.8703738887725;4340.327249276367;4054.6958978076614;4244.983632774438;4250.128723611652;4282.678799090049;4320.546342634009;3582.874599389009;3658.414653655429;3774.8490060397553;3840.5213992612767;3949.308870947573;4103.701926920904;4768.904621907543;4918.991606720614;4925.931108934256;5058.140116180258;4602.895305126745;4673;4683.953160468386;5014.420457555858;5048.570871475929;4939.851804445872;5577.079781836032;5614.831555053355;5632.915506267409;5671.517920976722;3689.8377011241373;4020.9344523701243;4101.323281658522;4289.806958686867;4478.753668548228;5717.742701578439;5965.673387378883;5982.4914882234625;6039.429748265438;6063.514918806485;3932.4691166692132;4108.226946810891;4511.811771290922;4581.473130590025;4584.15193189261;3833.5399752029934;4192.685548583808;4652.767361631905;4700.576948074689;4719.480857105716;4132.504099508018;4866.31871537985;4894.99652571222;4987.825426110068;5026.396832380065;5106.591472682177;5211.140161873324;5562.749676264578;5591.4558875711455;5597;1321.894248460121;1361.006465280331;1401.0752903083915;1451.1293224065687;1567.4169089219743;1000.8598796168542;1014.9801894230428;1044.6552637629563;1173.6889724223088;1187.7386974865515;4418.491873434532;4500.324951257272;4754.264693386958;4840.661153719206;5081.814819627596;5203.531682148625;5214.59206014374;5651.6043876928225;5825.213611152784;5825.427039773757;4427.454213827063;4616.676832621752;4925.202301160122;5107.208382700687;5211.0234725836735;2421.8304718669524;2602.7787638050977;2786.21985843964;2930.1063175731606;3087.922801929925;5381.515663590296;5381.811636592701;5505.917411238835;5813.941860581424;6025.849353766103;4567.520410356931;4867.440244371872;5814.244148260699;5979.970100149471;5994.880102397928;5664.130836823838;5894.646321220741;5905.143754155623;5905.881882362329;6070.362611925861;4995.550400463976;5446.937847119773;5699.699279669781;5861.824145275648;5891.970540147272;5277.2875661785165;5471.671699698031;5570.916436253378;5832.883342333214;5838.511179649162;5072.195853110167;5137.842106315282;5830.591858570029;6048.90926636092;6059.000529825235;4041.4948131483566;4532.864014079583;4559.4756602989755;4585.71599952014;4642.605378542862;4825.9034819302715;5143.225587172419;5768.94231057684;5786.363500014911;5788.479036886701;5337.306150200449;5536.114221724505;5643.448051785792;5647.915281270702;5715.828525144252;5184.300119483973;5291.592325491969;5563.58273129525;5578.525825304732;5644.6330988485615;5094.312267843942;5104.69371837691;5309.946900530946;5517.503424691797;5541.251930989426;5024.969881174424;5300.70846103468;5357;5568.7399139659;5667.631603945731;4413.779311034371;4724.385829842098;5202.791888324576;5450.784037417942;5521.972390138024 06:55:36 INFO - PROCESS | 1635 | |5;yui.html;704.7533363322838;712.8146681862714;762.7139822566537;818.9754307370778;834.7954751085983;12917.418716157772;16023.27895244714;16114;16135.757963630555;16186.91906540467;14310.642233944156;15365.539033829004;15379.769303460429;15393.307301171446;15412.152331621757;798.6845196147518;844.8605980013291;879.9560021998874;942.0155937045804;946.5551190940247;888.4669198480892;909.05912380686;940.3417607674655;941.7127776028309;950.3062764182151;837.2841220756258;998.1914649134225;998.5656239535789;1001.8747656542932;1002.2382988928395;836.4312267657959;985.9260555458334;990.2523594685966;990.697837159666;990.7027891632517;728.3626826526789;733.6881825224258;738.5679377564131;740.3558903753768;747.8840779679158;15810.762838557432;15896.443624473088;16226.513204603882;16668.83331166685;16915.492535223962;13715;13932.303384830719;14006.22965736884;14067.859321406757;14260.786088208684;10871.67384978452;11436;11573.479193436315;11703.882961170364;12096.697582560419;4203.663706903471;4211.789410529461;4329.523752387235;4387.312981488993;4428.734275943454;99332.52336168199;102276;102950.48524757403;103619.48190259076;104066;10326.22553308505;10338.431386273676;10528.526216320284;10594.947025264824;11045;16847.241874115694;20845.68731469029;21002.684959725615;21067.367978960654;21130.894345528173;7356.227596102439;7418.183999760022;7489.400847932152;7558.848823023509;7668.5782281975025;4084;4138.565450627701;4190.497140343117;4199.958000420018;4231.978840105779;3235.53084802707;3289.358575077885;3316.4859446785304;3324.700776930088;3325.1022223999385;595.3956733914993;595.6217801695955;609.20194545146;613.7851751886803;614.9538784591174;463.39295522865154;515.1577171324836;524.1299442924727;529.6186745543203;558.7730854316275;9457.38526995743;9641.084097010773;9674.951625241829;9730.805383892282;9775.90224097764;510.1276816643581;510.7114480318608;533.3493138371181;546.5327145290798;549.1574975801558;4010.258102251093;4173.227952828736;5046.39443266803;5476.479734425223;5484.561235101182;82305.58847205725;98256;100959.48560771595;102446.48776756218;102895;71203.28796711967;74052;82766;82818;84820;74265;74760;75355;75594.11014724566;76145;8120.903678003394;10740.063229475423;10853.782924341627;10856.565737370416;10947.416817423013;39092.6090739089;44784.43254486077;44813.551864480934;46934.765326174514;47741.80645483891;55952.720236398556;63076.73846522952;63235.051474227;63456.41358966063;64178;11778.234414763356;11934.164608477324;12051.75896482083;12563.246205227715;12563.560275390317;11386.54453821871;14156.787648185491;14270.857291426953;14560.781588276397;14576.052556583789;13440.260785656883;13622.727545449234;13762.862371376157;13791.51729689456;13899;13470.93264533671;13474.66313342135;13485.39315730814;13693.794593081311;13977.930110349384;11625.825612615648;13148.539801106916;13473.932630336785;13987.370568324654;14038.505729900193;10632.203843371128;10838.891611083789;10960.56157753681;10980.176486763365;11148.554057837595;6939.892894253025;9206.320668025059;10540.209484288862;10925.562977480811;11205.271657342246 06:55:36 INFO - PROCESS | 1635 | __end_tp_report 06:55:36 INFO - PROCESS | 1635 | __start_cc_report 06:55:36 INFO - PROCESS | 1635 | _x_x_mozilla_cycle_collect,431 06:55:36 INFO - PROCESS | 1635 | __end_cc_report 06:55:36 INFO - PROCESS | 1635 | __startTimestamp1488984936325__endTimestamp 06:55:36 INFO - PROCESS | 1635 | 06:55:36 INFO - PROCESS | 1635 | ------- Summary: start ------- 06:55:36 INFO - PROCESS | 1635 | Number of tests: 6 06:55:36 INFO - PROCESS | 1635 | 06:55:36 INFO - PROCESS | 1635 | [#0] dojo.html Cycles:165 Average:5870.95 Median:6132.39 stddev:680.16 (11.1%) stddev-sans-first:644.34 06:55:36 INFO - PROCESS | 1635 | Values: 3016.8 3442.5 3465.5 3466.0 3489.1 5798.0 5945.1 5958.4 5960.3 6064.3 5827.5 5871.8 5900.7 5933.0 6060.2 5219.9 5297.0 5377.5 5395.6 5452.2 4600.8 5329.1 5399.1 5448.9 5477.7 5400.5 5421.6 5460.1 5463.4 5471.0 5191.8 5283.2 5286.0 5321.6 5326.0 5323.8 5334.9 5342.0 5360.9 5403.4 4240.8 5800.7 5908.3 5911.5 5987.3 6241.7 6249.3 6325.4 6333.6 6366.9 5528.2 5985.8 6296.5 6394.0 6427.4 6099.5 6106.0 6114.8 6115.5 6125.5 6279.6 6495.9 6558.3 6585.2 6615.9 6164.2 6216.4 6252.7 6266.3 6292.6 6300.8 6345.4 6347.5 6348.1 6354.1 6231.5 6314.7 6320.7 6327.7 6335.7 5671.0 6263.6 6348.3 6358.1 6449.7 5030.9 5061.0 5109.7 5130.7 5157.4 4584.6 4584.7 4601.6 4619.8 4620.8 6142.9 6148.1 6154.4 6157.1 6157.8 5124.8 6295.0 6363.2 6396.8 6420.2 6060.6 6080.8 6102.9 6122.2 6124.6 5638.4 5655.2 5666.5 5669.0 5669.3 6330.0 6591.6 6618.3 6634.4 6675.6 6249.5 6309.8 6327.7 6340.7 6380.5 5094.6 6606.1 6634.1 6651.2 6667.1 5784.5 6296.6 6311.6 6339.0 6385.1 5687.8 6272.4 6287.2 6316.5 6319.2 6291.6 6299.9 6311.4 6322.6 6328.6 6107.6 6123.6 6305.2 6329.9 6335.7 5064.5 5306.7 5787.2 6132.4 6144.0 6214.6 6247.3 6320.3 6323.4 6354.6 6201.3 6210.3 6211.9 6231.7 6248.8 06:55:36 INFO - PROCESS | 1635 | 06:55:36 INFO - PROCESS | 1635 | [#1] ext.html Cycles:180 Average:53240.99 Median:30809.73 stddev:110924.25 (360.0%) stddev-sans-first:111165.50 06:55:36 INFO - PROCESS | 1635 | Values: 782.1 800.1 834.4 864.8 935.9 35635.0 36402.0 36403.8 37511.8 37712.4 36117.0 36381.0 36387.8 36446.8 36526.5 7532.6 7662.3 7690.5 10161.0 10432.4 8506.7 10234.3 10325.8 10328.2 10357.6 10366.6 10385.7 10398.7 10403.0 10421.5 10323.5 10332.9 10346.9 10377.4 10380.6 10158.8 10183.7 10216.2 10232.2 10236.4 31877.0 32072.5 32083.0 32133.8 32161.5 3631.1 3661.7 3666.2 3670.9 3814.3 22714.2 24626.9 24910.3 24928.3 24953.4 2813.9 2934.1 3025.7 3073.2 3105.5 310451.0 346864.0 347096.0 351405.0 351544.0 36431.0 36827.8 39423.6 40883.0 41650.4 43573.8 43625.8 43729.3 43730.6 43805.0 10393.4 12677.6 12753.7 12820.0 12823.2 9104.5 10915.7 10936.0 10938.4 10952.6 11328.5 11332.0 11343.5 11423.1 11450.3 5571.9 5581.2 5609.4 5613.9 5629.9 805.0 900.4 906.6 943.5 973.4 19437.9 24671.5 26389.2 27343.9 27393.9 1003.6 1010.4 1035.6 1047.4 1051.2 11857.6 11979.8 13228.3 14111.3 14156.0 451061.0 453724.0 454948.0 455413.7 455551.0 51951.0 52045.5 52363.5 52458.2 52529.7 1341.7 1412.4 1412.8 1417.7 1424.4 25303.5 26289.9 26479.0 26562.0 26792.2 42219.4 42329.9 43086.1 44257.9 44519.9 444570.0 444638.0 445724.8 445796.0 447732.0 22840.7 23305.0 26796.7 27493.2 27621.8 35768.6 36522.6 36562.6 36590.6 36754.9 28275.4 31083.7 31179.0 31209.8 31524.4 30646.9 30671.9 30753.9 30962.8 31123.2 27725.6 29036.6 30375.4 30865.5 30919.0 27189.9 27524.4 27535.9 27746.9 28237.9 21668.6 21805.3 21851.3 21875.5 21896.6 06:55:36 INFO - PROCESS | 1635 | 06:55:36 INFO - PROCESS | 1635 | [#2] jquery.html Cycles:180 Average:40984.97 Median:21810.28 stddev:117088.43 (536.8%) stddev-sans-first:117377.22 06:55:36 INFO - PROCESS | 1635 | Values: 391.6 392.5 405.2 423.4 433.8 16196.8 19562.1 20562.7 20882.7 20888.4 20771.0 20879.8 21022.7 21338.4 21551.9 5382.3 5423.4 5512.2 6616.0 6637.3 6377.2 6471.8 6477.5 6489.4 6595.5 6541.5 6543.6 6549.1 6569.5 6575.8 6271.3 6581.2 6595.4 6625.6 6630.6 6452.2 6463.1 6473.2 6757.7 7088.8 22068.7 22510.0 24318.6 25639.3 26131.7 2639.8 2852.4 2894.3 2913.3 2926.3 13694.2 15255.0 15282.2 15353.4 16470.0 1732.3 1971.0 1989.9 2041.6 2119.2 125191.0 154748.0 157796.4 158508.4 159043.0 18641.7 20483.6 20497.6 20776.1 20816.9 31070.5 31091.4 31128.0 31322.0 31338.0 9640.3 9885.0 10088.7 10255.6 10305.6 8272.6 8284.7 8312.7 8415.0 8476.3 9319.9 9677.0 9678.3 9705.0 9896.1 3530.5 4086.5 4151.6 4201.4 4226.8 997.3 1004.2 1004.6 1011.3 1047.3 19167.6 20240.5 20264.0 20293.4 20499.5 826.6 949.8 991.7 1026.4 1033.8 9137.7 9334.6 9784.9 9813.8 10570.6 686343.0 687206.0 688793.0 712833.0 715280.0 148526.0 149791.3 161903.0 172917.0 176236.0 1231.2 1296.6 1314.0 1318.3 1327.7 19417.6 19507.0 19558.9 19701.7 19812.6 38517.4 57146.0 58168.4 58691.7 62579.0 61778.0 77273.0 80431.0 82505.0 84793.0 10526.7 10924.1 11357.2 11621.2 11798.0 12605.1 12792.6 13029.2 13053.4 13164.1 10920.5 10949.6 10980.8 11171.7 11225.4 9505.9 9958.0 10727.2 10812.8 11143.4 8656.9 10719.8 10977.9 11382.4 11562.4 9270.9 10955.2 11484.8 11759.8 11795.2 10835.7 10870.3 11109.9 11131.6 11249.8 06:55:36 INFO - PROCESS | 1635 | 06:55:36 INFO - PROCESS | 1635 | [#3] mootools.html Cycles:180 Average:6619.34 Median:2352.00 stddev:4146.53 (176.3%) stddev-sans-first:4139.04 06:55:36 INFO - PROCESS | 1635 | Values: 1320.3 1396.5 1552.8 1597.3 1607.8 9227.2 9995.5 10564.9 10739.4 10991.8 9567.3 10676.7 10840.6 10990.0 11050.3 1829.4 2322.8 2362.5 2368.7 2370.5 2225.2 2254.2 2256.9 2262.4 2273.6 2310.7 2331.2 2338.6 2338.8 2341.5 2202.6 2216.6 2223.2 2224.2 2226.4 2254.0 2315.3 2317.6 2318.5 2323.7 10923.8 10945.2 10994.7 11016.8 11020.8 5693.3 5803.1 5862.7 5889.4 5909.4 3320.3 3392.1 3611.8 3614.5 3618.1 1141.5 1159.2 1164.9 1186.7 1207.9 14944.3 15018.3 15178.3 15201.5 15247.9 4381.3 4601.8 4687.6 4689.9 4696.3 11226.9 11232.4 11243.8 11258.4 11268.9 5575.9 5594.4 5601.7 5614.2 5617.0 4981.1 5040.4 5120.1 5168.7 5207.8 3774.8 3814.5 3818.7 3892.0 3906.8 1023.8 1028.1 1036.3 1050.8 1051.8 781.6 818.2 870.5 921.3 924.3 6341.1 6387.4 6544.7 6613.6 6659.4 851.4 1074.0 1080.8 1102.3 1104.9 3553.2 3615.1 4330.7 4339.8 4586.7 12643.6 12796.4 13396.5 13496.2 13831.4 13079.1 13315.0 13334.3 13346.1 13365.2 9829.2 9935.7 10062.2 10083.7 10085.6 6383.8 6602.4 6702.6 6738.8 6859.7 11503.9 11950.5 11955.3 12041.6 12141.4 11839.3 12115.6 12340.0 12410.3 12413.3 9139.0 9157.8 9352.3 9358.4 9370.6 10176.9 10219.7 10279.7 10289.2 10302.9 8876.9 8999.3 9061.8 9070.7 9241.4 8909.6 8915.2 8950.1 9089.9 9097.0 7599.9 7712.7 7764.8 7770.0 7774.8 4803.6 5664.0 5666.8 5737.5 5845.4 5075.0 5869.1 5980.7 6006.0 6053.8 06:55:36 INFO - PROCESS | 1635 | 06:55:36 INFO - PROCESS | 1635 | [#4] prototype.html Cycles:180 Average:4594.18 Median:4932.89 stddev:1334.25 (27.0%) stddev-sans-first:1298.81 06:55:36 INFO - PROCESS | 1635 | Values: 317.7 367.8 369.5 385.6 389.8 5293.6 5350.8 5368.0 5383.3 5408.6 3997.7 4450.8 4492.2 4611.4 5246.6 3686.9 3732.7 3832.8 3867.0 4078.4 3441.4 4272.4 4315.2 4326.0 4355.2 3608.6 4305.1 4314.0 4320.9 4340.3 4054.7 4245.0 4250.1 4282.7 4320.5 3582.9 3658.4 3774.8 3840.5 3949.3 4103.7 4768.9 4919.0 4925.9 5058.1 4602.9 4673.0 4684.0 5014.4 5048.6 4939.9 5577.1 5614.8 5632.9 5671.5 3689.8 4020.9 4101.3 4289.8 4478.8 5717.7 5965.7 5982.5 6039.4 6063.5 3932.5 4108.2 4511.8 4581.5 4584.2 3833.5 4192.7 4652.8 4700.6 4719.5 4132.5 4866.3 4895.0 4987.8 5026.4 5106.6 5211.1 5562.7 5591.5 5597.0 1321.9 1361.0 1401.1 1451.1 1567.4 1000.9 1015.0 1044.7 1173.7 1187.7 4418.5 4500.3 4754.3 4840.7 5081.8 5203.5 5214.6 5651.6 5825.2 5825.4 4427.5 4616.7 4925.2 5107.2 5211.0 2421.8 2602.8 2786.2 2930.1 3087.9 5381.5 5381.8 5505.9 5813.9 6025.8 4567.5 4867.4 5814.2 5980.0 5994.9 5664.1 5894.6 5905.1 5905.9 6070.4 4995.6 5446.9 5699.7 5861.8 5892.0 5277.3 5471.7 5570.9 5832.9 5838.5 5072.2 5137.8 5830.6 6048.9 6059.0 4041.5 4532.9 4559.5 4585.7 4642.6 4825.9 5143.2 5768.9 5786.4 5788.5 5337.3 5536.1 5643.4 5647.9 5715.8 5184.3 5291.6 5563.6 5578.5 5644.6 5094.3 5104.7 5309.9 5517.5 5541.3 5025.0 5300.7 5357.0 5568.7 5667.6 4413.8 4724.4 5202.8 5450.8 5522.0 06:55:36 INFO - PROCESS | 1635 | 06:55:36 INFO - PROCESS | 1635 | [#5] yui.html Cycles:180 Average:19506.99 Median:4181.86 stddev:27551.28 (658.8%) stddev-sans-first:27592.39 06:55:36 INFO - PROCESS | 1635 | Values: 704.8 712.8 762.7 819.0 834.8 12917.4 16023.3 16114.0 16135.8 16186.9 14310.6 15365.5 15379.8 15393.3 15412.2 798.7 844.9 880.0 942.0 946.6 888.5 909.1 940.3 941.7 950.3 837.3 998.2 998.6 1001.9 1002.2 836.4 985.9 990.3 990.7 990.7 728.4 733.7 738.6 740.4 747.9 15810.8 15896.4 16226.5 16668.8 16915.5 13715.0 13932.3 14006.2 14067.9 14260.8 10871.7 11436.0 11573.5 11703.9 12096.7 4203.7 4211.8 4329.5 4387.3 4428.7 99332.5 102276.0 102950.5 103619.5 104066.0 10326.2 10338.4 10528.5 10594.9 11045.0 16847.2 20845.7 21002.7 21067.4 21130.9 7356.2 7418.2 7489.4 7558.8 7668.6 4084.0 4138.6 4190.5 4200.0 4232.0 3235.5 3289.4 3316.5 3324.7 3325.1 595.4 595.6 609.2 613.8 615.0 463.4 515.2 524.1 529.6 558.8 9457.4 9641.1 9675.0 9730.8 9775.9 510.1 510.7 533.3 546.5 549.2 4010.3 4173.2 5046.4 5476.5 5484.6 82305.6 98256.0 100959.5 102446.5 102895.0 71203.3 74052.0 82766.0 82818.0 84820.0 74265.0 74760.0 75355.0 75594.1 76145.0 8120.9 10740.1 10853.8 10856.6 10947.4 39092.6 44784.4 44813.6 46934.8 47741.8 55952.7 63076.7 63235.1 63456.4 64178.0 11778.2 11934.2 12051.8 12563.2 12563.6 11386.5 14156.8 14270.9 14560.8 14576.1 13440.3 13622.7 13762.9 13791.5 13899.0 13470.9 13474.7 13485.4 13693.8 13977.9 11625.8 13148.5 13473.9 13987.4 14038.5 10632.2 10838.9 10960.6 10980.2 11148.6 6939.9 9206.3 10540.2 10925.6 11205.3 06:55:36 INFO - PROCESS | 1635 | -------- Summary: end -------- 06:55:36 INFO - PROCESS | 1635 | 06:55:36 INFO - TEST-INFO | 1635: exit 0 06:55:37 INFO - TEST-OK | dromaeo_css | took 1117948ms 06:55:37 INFO - TEST-START | kraken 06:55:37 INFO - operating with platform_type : mac_ 06:55:37 INFO - Initialising browser for kraken test... 06:55:37 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/tmpQWYFX0/profile http://localhost:49241/getInfo.html) 06:55:40 INFO - PROCESS | 1646 | 2017-03-08 06:55:40.030 plugin-container[1647:10147] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a3f, name = 'com.apple.tsm.portname' 06:55:40 INFO - PROCESS | 1646 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:55:40 INFO - PROCESS | 1646 | 2017-03-08 06:55:40.033 plugin-container[1647:10147] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0b, name = 'com.apple.CFPasteboardClient' 06:55:40 INFO - PROCESS | 1646 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:55:40 INFO - PROCESS | 1646 | 2017-03-08 06:55:40.034 plugin-container[1647:10147] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 06:55:40 INFO - PROCESS | 1646 | __metrics Screen width/height:1600/1200 06:55:40 INFO - PROCESS | 1646 | colorDepth:24 06:55:40 INFO - PROCESS | 1646 | Browser inner width/height: 1024/689 06:55:40 INFO - PROCESS | 1646 | __metrics 06:55:40 ERROR - PROCESS | 1646 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3353: TypeError: this.tabs is undefined 06:55:40 INFO - TEST-INFO | 1646: exit 0 06:55:40 INFO - Browser initialized. 06:55:40 INFO - Running cycle 1/1 for kraken test... 06:55:40 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/tmpQWYFX0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:55:43 INFO - PROCESS | 1648 | 2017-03-08 06:55:43.486 plugin-container[1649:10277] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c47, name = 'com.apple.tsm.portname' 06:55:43 INFO - PROCESS | 1648 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:55:43 INFO - PROCESS | 1648 | 2017-03-08 06:55:43.487 plugin-container[1649:10277] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x470f, name = 'com.apple.CFPasteboardClient' 06:55:43 INFO - PROCESS | 1648 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:55:43 INFO - PROCESS | 1648 | 2017-03-08 06:55:43.487 plugin-container[1649:10277] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 06:55:53 INFO - PROCESS | 1648 | RSS: Main: 226856960 06:55:53 INFO - PROCESS | 1648 | 06:55:56 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 06:55:57 INFO - PROCESS | 1648 | RSS: Main: 241164288 06:55:57 INFO - PROCESS | 1648 | 06:55:59 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 06:56:00 INFO - PROCESS | 1648 | RSS: Main: 249597952 06:56:00 INFO - PROCESS | 1648 | 06:56:03 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 06:56:04 INFO - PROCESS | 1648 | RSS: Main: 252141568 06:56:04 INFO - PROCESS | 1648 | 06:56:06 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 06:56:06 INFO - PROCESS | 1648 | RSS: Main: 253390848 06:56:06 INFO - PROCESS | 1648 | 06:56:09 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:56:09 INFO - PROCESS | 1648 | RSS: Main: 253739008 06:56:09 INFO - PROCESS | 1648 | 06:56:12 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 06:56:13 INFO - PROCESS | 1648 | RSS: Main: 261234688 06:56:13 INFO - PROCESS | 1648 | 06:56:17 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 06:56:17 INFO - PROCESS | 1648 | RSS: Main: 258654208 06:56:17 INFO - PROCESS | 1648 | 06:56:21 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 06:56:21 INFO - PROCESS | 1648 | RSS: Main: 259694592 06:56:21 INFO - PROCESS | 1648 | 06:56:23 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:56:23 INFO - PROCESS | 1648 | RSS: Main: 260157440 06:56:23 INFO - PROCESS | 1648 | 06:56:25 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:56:26 INFO - PROCESS | 1648 | RSS: Main: 260153344 06:56:26 INFO - PROCESS | 1648 | 06:56:28 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:56:29 INFO - PROCESS | 1648 | RSS: Main: 260304896 06:56:29 INFO - PROCESS | 1648 | 06:56:32 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:56:33 INFO - PROCESS | 1648 | RSS: Main: 260853760 06:56:33 INFO - PROCESS | 1648 | 06:56:36 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:56:36 INFO - PROCESS | 1648 | RSS: Main: 260329472 06:56:36 INFO - PROCESS | 1648 | 06:56:38 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 06:56:39 INFO - PROCESS | 1648 | RSS: Main: 263798784 06:56:39 INFO - PROCESS | 1648 | 06:56:39 INFO - PROCESS | 1648 | __start_tp_report 06:56:39 INFO - PROCESS | 1648 | _x_x_mozilla_page_load 06:56:39 INFO - PROCESS | 1648 | _x_x_mozilla_page_load_details 06:56:39 INFO - PROCESS | 1648 | |i|pagename|runs| 06:56:39 INFO - PROCESS | 1648 | |0;ai-astar;109;121;119;99;171;178;169;120;121;121 06:56:39 INFO - PROCESS | 1648 | |1;audio-beat-detection;170;151;123;184;139;109;111;113;130;113 06:56:39 INFO - PROCESS | 1648 | |2;audio-dft;194;209;218;221;201;195;197;195;200;193 06:56:39 INFO - PROCESS | 1648 | |3;audio-fft;81;64;62;85;62;66;70;85;100;86 06:56:39 INFO - PROCESS | 1648 | |4;audio-oscillator;88;71;85;78;104;103;78;88;87;107 06:56:39 INFO - PROCESS | 1648 | |5;imaging-gaussian-blur;90;90;113;100;86;87;76;77;80;129 06:56:39 INFO - PROCESS | 1648 | |6;imaging-darkroom;102;92;124;94;130;157;122;122;154;97 06:56:39 INFO - PROCESS | 1648 | |7;imaging-desaturate;109;107;148;146;90;93;90;90;91;90 06:56:39 INFO - PROCESS | 1648 | |8;json-parse-financial;68;66;66;68;67;67;67;66;67;67 06:56:39 INFO - PROCESS | 1648 | |9;json-stringify-tinderbox;58;65;60;65;64;58;58;71;87;83 06:56:39 INFO - PROCESS | 1648 | |10;stanford-crypto-aes;85;91;87;87;88;99;112;115;74;107 06:56:39 INFO - PROCESS | 1648 | |11;stanford-crypto-ccm;161;165;140;146;151;154;140;142;188;161 06:56:39 INFO - PROCESS | 1648 | |12;stanford-crypto-pbkdf2;181;180;159;213;178;176;173;205;159;214 06:56:39 INFO - PROCESS | 1648 | |13;stanford-crypto-sha256-iterative;69;69;71;82;90;68;71;71;85;88 06:56:39 INFO - PROCESS | 1648 | __end_tp_report 06:56:39 INFO - PROCESS | 1648 | __start_cc_report 06:56:39 INFO - PROCESS | 1648 | _x_x_mozilla_cycle_collect,989 06:56:39 INFO - PROCESS | 1648 | __end_cc_report 06:56:39 INFO - PROCESS | 1648 | __startTimestamp1488984999053__endTimestamp 06:56:39 INFO - PROCESS | 1648 | 06:56:39 INFO - PROCESS | 1648 | ------- Summary: start ------- 06:56:39 INFO - PROCESS | 1648 | Number of tests: 14 06:56:39 INFO - PROCESS | 1648 | 06:56:39 INFO - PROCESS | 1648 | [#0] ai-astar Cycles:10 Average:132.80 Median:145.00 stddev:28.47 (19.6%) stddev-sans-first:28.86 06:56:39 INFO - PROCESS | 1648 | Values: 109.0 121.0 119.0 99.0 171.0 178.0 169.0 120.0 121.0 121.0 06:56:39 INFO - PROCESS | 1648 | 06:56:39 INFO - PROCESS | 1648 | [#1] audio-beat-detection Cycles:10 Average:134.30 Median:134.50 stddev:26.42 (19.6%) stddev-sans-first:24.66 06:56:39 INFO - PROCESS | 1648 | Values: 170.0 151.0 123.0 184.0 139.0 109.0 111.0 113.0 130.0 113.0 06:56:39 INFO - PROCESS | 1648 | 06:56:39 INFO - PROCESS | 1648 | [#2] audio-dft Cycles:10 Average:202.30 Median:200.50 stddev:10.21 (5.1%) stddev-sans-first:10.38 06:56:39 INFO - PROCESS | 1648 | Values: 194.0 209.0 218.0 221.0 201.0 195.0 197.0 195.0 200.0 193.0 06:56:39 INFO - PROCESS | 1648 | 06:56:39 INFO - PROCESS | 1648 | [#3] audio-fft Cycles:10 Average:76.10 Median:75.50 stddev:13.06 (17.3%) stddev-sans-first:13.73 06:56:39 INFO - PROCESS | 1648 | Values: 81.0 64.0 62.0 85.0 62.0 66.0 70.0 85.0 100.0 86.0 06:56:39 INFO - PROCESS | 1648 | 06:56:39 INFO - PROCESS | 1648 | [#4] audio-oscillator Cycles:10 Average:88.90 Median:81.50 stddev:12.17 (14.9%) stddev-sans-first:12.90 06:56:39 INFO - PROCESS | 1648 | Values: 88.0 71.0 85.0 78.0 104.0 103.0 78.0 88.0 87.0 107.0 06:56:39 INFO - PROCESS | 1648 | 06:56:39 INFO - PROCESS | 1648 | [#5] imaging-gaussian-blur Cycles:10 Average:92.80 Median:83.00 stddev:16.87 (20.3%) stddev-sans-first:17.86 06:56:39 INFO - PROCESS | 1648 | Values: 90.0 90.0 113.0 100.0 86.0 87.0 76.0 77.0 80.0 129.0 06:56:39 INFO - PROCESS | 1648 | 06:56:39 INFO - PROCESS | 1648 | [#6] imaging-darkroom Cycles:10 Average:119.40 Median:155.50 stddev:23.47 (15.1%) stddev-sans-first:24.04 06:56:39 INFO - PROCESS | 1648 | Values: 102.0 92.0 124.0 94.0 130.0 157.0 122.0 122.0 154.0 97.0 06:56:39 INFO - PROCESS | 1648 | 06:56:39 INFO - PROCESS | 1648 | [#7] imaging-desaturate Cycles:10 Average:105.40 Median:90.00 stddev:23.07 (25.6%) stddev-sans-first:24.43 06:56:39 INFO - PROCESS | 1648 | Values: 109.0 107.0 148.0 146.0 90.0 93.0 90.0 90.0 91.0 90.0 06:56:39 INFO - PROCESS | 1648 | 06:56:39 INFO - PROCESS | 1648 | [#8] json-parse-financial Cycles:10 Average:66.90 Median:67.00 stddev:0.74 (1.1%) stddev-sans-first:0.67 06:56:39 INFO - PROCESS | 1648 | Values: 68.0 66.0 66.0 68.0 67.0 67.0 67.0 66.0 67.0 67.0 06:56:39 INFO - PROCESS | 1648 | 06:56:39 INFO - PROCESS | 1648 | [#9] json-stringify-tinderbox Cycles:10 Average:66.90 Median:65.00 stddev:10.44 (16.1%) stddev-sans-first:10.56 06:56:39 INFO - PROCESS | 1648 | Values: 58.0 65.0 60.0 65.0 64.0 58.0 58.0 71.0 87.0 83.0 06:56:39 INFO - PROCESS | 1648 | 06:56:39 INFO - PROCESS | 1648 | [#10] stanford-crypto-aes Cycles:10 Average:94.50 Median:87.00 stddev:13.25 (15.2%) stddev-sans-first:13.60 06:56:39 INFO - PROCESS | 1648 | Values: 85.0 91.0 87.0 87.0 88.0 99.0 112.0 115.0 74.0 107.0 06:56:39 INFO - PROCESS | 1648 | 06:56:39 INFO - PROCESS | 1648 | [#11] stanford-crypto-ccm Cycles:10 Average:154.80 Median:157.50 stddev:14.82 (9.4%) stddev-sans-first:15.55 06:56:39 INFO - PROCESS | 1648 | Values: 161.0 165.0 140.0 146.0 151.0 154.0 140.0 142.0 188.0 161.0 06:56:39 INFO - PROCESS | 1648 | 06:56:39 INFO - PROCESS | 1648 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.80 Median:180.50 stddev:20.21 (11.2%) stddev-sans-first:21.42 06:56:39 INFO - PROCESS | 1648 | Values: 181.0 180.0 159.0 213.0 178.0 176.0 173.0 205.0 159.0 214.0 06:56:39 INFO - PROCESS | 1648 | 06:56:39 INFO - PROCESS | 1648 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.40 Median:76.50 stddev:8.77 (11.5%) stddev-sans-first:8.89 06:56:39 INFO - PROCESS | 1648 | Values: 69.0 69.0 71.0 82.0 90.0 68.0 71.0 71.0 85.0 88.0 06:56:39 INFO - PROCESS | 1648 | -------- Summary: end -------- 06:56:39 INFO - PROCESS | 1648 | 06:56:39 INFO - TEST-INFO | 1648: exit 0 06:56:39 INFO - TEST-OK | kraken | took 62944ms 06:56:39 INFO - SUITE-END | took 1180s 06:56:40 INFO - Completed test suite (00:19:41) 06:56:40 INFO - javascript benchmark 06:56:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7480.727613442553, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3016.834074125923, 3442.50083737858, 3465.4975028620865, 3466.01218652684, 3489.057954352325, 5798.0, 5945.108233764938, 5958.374370691075, 5960.344362120163, 6064.272287325516, 5827.504662103726, 5871.794487192949, 5900.734466948987, 5932.970335148329, 6060.151578778975, 5219.903820197763, 5296.973515132419, 5377.542908852753, 5395.59533035022, 5452.2094296327, 4600.769961501928, 5329.094054010808, 5399.055165346068, 5448.891022179554, 5477.698726570037, 5400.459954004587, 5421.647592906448, 5460.099083651193, 5463.3717122530825, 5471.0, 5191.844244672666, 5283.1546952487415, 5285.973570132125, 5321.600879933982, 5325.973370133163, 5323.760430780585, 5334.893302133935, 5341.973290133564, 5360.865978350534, 5403.405625381244, 4240.809163587646, 5800.651960882318, 5908.291005079375, 5911.497522710575, 5987.311459182206, 6241.7191226394925, 6249.343818899041, 6325.430711236011, 6333.55665103443, 6366.87266254677, 5528.198411230389, 5985.790497332572, 6296.464800491964, 6394.0, 6427.357264273582, 6099.451049405575, 6106.0, 6114.755409783648, 6115.541334399938, 6125.540584456139, 6279.623222606659, 6495.902561461582, 6558.311377305315, 6585.209774826955, 6615.933840661532, 6164.167837341902, 6216.378362163748, 6252.6873656317, 6266.310705822356, 6292.622442653455, 6300.810975670737, 6345.428911397997, 6347.460465860454, 6348.111264422984, 6354.142190804275, 6231.501479881598, 6314.652694101868, 6320.652364120017, 6327.683615819191, 6335.746570137235, 5670.950874088307, 6263.561550691499, 6348.333424990402, 6358.141650877073, 6449.7420103195345, 5030.924536131961, 5061.0, 5109.744512774347, 5130.692158470503, 5157.355330583677, 4584.61030812378, 4584.701994370355, 4601.608863246662, 4619.769011549409, 4620.792064357112, 6142.938570614326, 6148.1085242639565, 6154.446099851035, 6157.107219453154, 6157.784477543264, 5124.846254612367, 6294.992801151885, 6363.172787537591, 6396.84007899797, 6420.1974753155855, 6060.636361818305, 6080.75676972925, 6102.938970610237, 6122.204113465221, 6124.6325220486915, 5638.407967163471, 5655.1799989001365, 5666.518345940559, 5668.95124401987, 5669.262995810601, 6330.0, 6591.571547849375, 6618.338166183343, 6634.436072933855, 6675.566088204251, 6249.531285153723, 6309.842253943688, 6327.651979141191, 6340.651264180515, 6380.457661098859, 5094.592432605456, 6606.075149479173, 6634.137562116894, 6651.16860392451, 6667.066610674412, 5784.4960310318775, 6296.5592408530965, 6311.558190926591, 6338.968305158629, 6385.074164246251, 5687.77248910039, 6272.40412160844, 6287.245530536365, 6316.494680425463, 6319.210098737658, 6291.591046581958, 6299.937000629935, 6311.431971122621, 6322.589031712924, 6328.588641738273, 6107.61364822091, 6123.618175568305, 6305.180326557702, 6329.8734025320155, 6335.683215839097, 5064.5441910228255, 5306.681599104066, 5787.160861675117, 6132.386102851662, 6144.03390914903, 6214.5960512566535, 6247.344028877084, 6320.304766475776, 6323.430891219812, 6354.555181137461, 6201.348858369806, 6210.347913469202, 6211.875762484635, 6231.688415579293, 6248.843778905563], "value": 5829.084148350203, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [782.0849605961025, 800.1398496616138, 834.3658819297332, 864.8270345930812, 935.8642996765474, 35635.0, 36402.0, 36403.81798091009, 37511.812440937756, 37712.43431348525, 36117.0, 36381.0, 36387.818060909725, 36446.8177659112, 36526.45210321847, 7532.623368831551, 7662.348700360448, 7690.461667683265, 10161.0, 10432.426216558086, 8506.74479765608, 10234.334768240078, 10325.793484130312, 10328.22538309626, 10357.585696572129, 10366.637167699131, 10385.688429347132, 10398.688039358794, 10403.0, 10421.53103110362, 10323.53544090514, 10332.896671033306, 10346.948265258625, 10377.429241391721, 10380.636677716318, 10158.796824063551, 10183.694489165337, 10216.233782466345, 10232.181425485944, 10236.385816851012, 31877.0, 32072.518912216336, 32083.0, 32133.839330803195, 32161.517577236362, 3631.074076110575, 3661.7253705971893, 3666.211764470652, 3670.944935825965, 3814.275287695357, 22714.205002824987, 24626.876865615737, 24910.252692419257, 24928.252152435274, 24953.376165595822, 2813.8885140369644, 2934.105097945126, 3025.6520500142547, 3073.247054471669, 3105.54969529417, 310451.0, 346864.0, 347096.0, 351405.0, 351544.0, 36431.0, 36827.81586092053, 39423.60576394256, 40883.0, 41650.37524437136, 43573.782131089145, 43625.78187109108, 43729.344059839124, 43730.562694373286, 43805.0, 10393.428361440043, 12677.556285529961, 12753.744925101631, 12820.038497112753, 12823.166494177849, 9104.499252541174, 10915.672529824118, 10936.031514327338, 10938.398388088572, 10952.616658416917, 11328.490217940212, 11332.0, 11343.489542970587, 11423.086153107897, 11450.255733377471, 5571.860703482445, 5581.162825576196, 5609.354924183771, 5613.905288468791, 5629.8592535186945, 804.9959750201211, 900.3697411811627, 906.5875026862761, 943.4858002388714, 973.425678849468, 19437.902810485855, 24671.506569868503, 26389.208323750318, 27343.906243750425, 27393.86303068472, 1003.6386900715737, 1010.4190090697878, 1035.6012935020071, 1047.4343854318736, 1051.206339213904, 11857.5849845255, 11979.820302695467, 13228.338583070808, 14111.294435278194, 14156.0, 451061.0, 453724.0, 454948.0, 455413.72293138324, 455551.0, 51951.0, 52045.47954520482, 52363.476365236624, 52458.21312680313, 52529.737351313, 1341.6712905338059, 1412.4251459622653, 1412.78808178774, 1417.7164567086418, 1424.4159894443228, 25303.493930121662, 26289.868550657888, 26479.0, 26562.0, 26792.19623411301, 42219.36670949877, 42329.94175145646, 43086.13827723491, 44257.893552661444, 44519.88700282519, 444570.0, 444638.0, 445724.77137614106, 445796.0, 447732.0, 22840.65739013883, 23304.951277192227, 26796.732032679425, 27493.17520474389, 27621.823490298873, 35768.64231357757, 36522.634773652986, 36562.63437365699, 36590.634093659784, 36754.897353079454, 28275.43449131047, 31083.68916310808, 31179.0, 31209.8439507801, 31524.36951261008, 30646.92735754238, 30671.85929899524, 30753.92361267345, 30962.845185773927, 31123.221919452193, 27725.584116238675, 29036.564451533668, 30375.392492149593, 30865.537016944316, 30919.0, 27189.86405067962, 27524.44951101007, 27535.86232068827, 27746.8901243948, 28237.858810705817, 21668.566628667653, 21805.345839624835, 21851.344459666234, 21875.453113672287, 21896.562068758216], "value": 17292.789153127265, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.5986114232909, 392.5132835284245, 405.1835551364, 423.4431722285195, 433.78323801736116, 16196.757048644251, 19562.11970461329, 20562.69155962662, 20882.686759698598, 20888.37334879954, 20771.0, 20879.791202087974, 21022.73863568187, 21338.35984920451, 21551.892240538775, 5382.273393091941, 5423.376311724162, 5512.228288039678, 6616.0406741022525, 6637.303083176269, 6377.234731832186, 6471.805845824632, 6477.54657173998, 6489.4483968862705, 6595.472362211036, 6541.47668186544, 6543.607383556978, 6549.1158693576235, 6569.540132190748, 6575.835604109888, 6271.310155882872, 6581.177352830896, 6595.406413422767, 6625.569337993015, 6630.6021638701595, 6452.161219041542, 6463.1274777904855, 6473.158489396395, 6757.662116894136, 7088.751893683748, 22068.668969965463, 22510.0, 24318.635220471708, 25639.333443326123, 26131.738682613122, 2639.838471072722, 2852.443773464175, 2894.3343031102963, 2913.300807806111, 2926.283060650133, 13694.178349299074, 15255.0, 15282.159481228528, 15353.385864565404, 16470.0, 1732.315735284568, 1971.0, 1989.8607097503182, 2041.5712700332947, 2119.2476670781803, 125191.0, 154748.0, 157796.42203578047, 158508.41491585167, 159043.0, 18641.7203741944, 20483.590328193353, 20497.59004819925, 20776.06507707157, 20816.85507297113, 31070.53394199089, 31091.378172436423, 31128.0, 31322.0, 31338.0, 9640.325177237666, 9884.950575247221, 10088.69733907984, 10255.641052563124, 10305.639302624371, 8272.627731752085, 8284.71003514886, 8312.709055183039, 8415.032271288757, 8476.27951624119, 9319.90680093204, 9676.951615241878, 9678.274129440179, 9705.029497050238, 9896.059874311928, 3530.5410296661785, 4086.468759061303, 4151.61556756325, 4201.432806571073, 4226.76752778594, 997.2769741937037, 1004.1565085328214, 1004.5680357446369, 1011.251673761426, 1047.3035431438161, 19167.616647666968, 20240.49398765013, 20264.0, 20293.391198264075, 20499.4875128123, 826.5908375354118, 949.8147861167145, 991.6925753016588, 1026.373911913732, 1033.751899544104, 9137.725868223832, 9334.626614935327, 9784.853227201598, 9813.80372392548, 10570.630027948984, 686343.0, 687206.0, 688793.0, 712833.0, 715280.0, 148526.0, 149791.25104374628, 161903.0, 172917.0, 176236.0, 1231.199720181889, 1296.6434230586665, 1314.0210543145417, 1318.3078883586002, 1327.7344531093627, 19417.611647767248, 19507.0, 19558.924259165884, 19701.70447443261, 19812.603747924673, 38517.422238667, 57146.0, 58168.4183158163, 58691.70654146702, 62579.0, 61778.0, 77273.0, 80431.0, 82505.0, 84793.0, 10526.736831579272, 10924.071453926505, 11357.204995650225, 11621.24461909973, 11798.0, 12605.054620903285, 12792.61622151337, 13029.218246905217, 13053.412596433373, 13164.14433061848, 10920.50857711389, 10949.616763413242, 10980.835287470854, 11171.66485005451, 11225.4387280634, 9505.906820715707, 9958.0, 10727.19546034035, 10812.783744325227, 11143.442827858413, 8656.870146947675, 10719.785604287714, 10977.945110274397, 11382.430878455878, 11562.364069976233, 9270.907290927003, 10955.24716045429, 11484.82772758426, 11759.823602645796, 11795.233309834834, 10835.67492975212, 10870.293430926964, 11109.944450277697, 11131.554737810397, 11249.775004500028], "value": 11209.275529875145, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1320.2738493828392, 1396.5391420831127, 1552.7748476470913, 1597.2652579813284, 1607.7990251218598, 9227.169554740072, 9995.450250236234, 10564.894351056488, 10739.355638661676, 10991.835122473169, 9567.330286879904, 10676.651136749922, 10840.566377344916, 10990.0, 11050.281731687435, 1829.387155302975, 2322.8025617822505, 2362.456634973957, 2368.692070030894, 2370.4784947311564, 2225.2100504320974, 2254.1546919905036, 2256.8533045352083, 2262.423082114067, 2273.6021196290667, 2310.688057112285, 2331.19573747057, 2338.6375111857687, 2338.8245881558864, 2341.5433990371885, 2202.559488102386, 2216.567769284982, 2223.1774243529835, 2224.2215224671318, 2226.4322597737637, 2254.030766770288, 2315.2591170825344, 2317.629179331299, 2318.501522172724, 2323.6630688550067, 10923.836142457869, 10945.179111566664, 10994.670159895137, 11016.779664406748, 11020.779584408347, 5693.316801983747, 5803.129530570406, 5862.677552734598, 5889.352171261158, 5909.438603332676, 3320.286138480214, 3392.050225936717, 3611.8261564991485, 3614.4759009943673, 3618.1135621772833, 1141.452102990561, 1159.2233203753506, 1164.9068074554016, 1186.730914738558, 1207.927524348542, 14944.327505262288, 15018.324175412023, 15178.316975736008, 15201.543953681297, 15247.932644714874, 4381.277089280233, 4601.838935637236, 4687.648426368036, 4689.906201875943, 4696.319033740088, 11226.93344132306, 11232.438378081064, 11243.775124497464, 11258.43707814606, 11268.887311126784, 5575.888482230333, 5594.384617692051, 5601.719914004365, 5614.1859430382365, 5617.01702202113, 4981.12830254704, 5040.36995375578, 5120.1039818031695, 5168.715720635326, 5207.765650545734, 3774.7735135891385, 3814.5231846019246, 3818.7326887118193, 3892.0, 3906.824192911326, 1023.8003589300015, 1028.0747327405395, 1036.290141253244, 1050.76883085721, 1051.75283808305, 781.5818537082633, 818.1899919080067, 870.4907629037084, 921.3090182363228, 924.306769922558, 6341.080543321193, 6387.425131738073, 6544.70548825304, 6613.570117942415, 6659.4006539411685, 851.3699862102, 1073.9677809665723, 1080.7514271717391, 1102.3385968419045, 1104.8508451358964, 3553.182767963383, 3615.060084378081, 4330.7401555906745, 4339.761313127745, 4586.656000799887, 12643.620691379274, 12796.360181990864, 13396.531121410704, 13496.190228586316, 13831.446742130403, 13079.084464087422, 13315.0, 13334.26661533625, 13346.065775395824, 13365.198088114745, 9829.164521015793, 9935.701928942288, 10062.195024398177, 10083.697489075339, 10085.638438810813, 6383.840403989938, 6602.379039058695, 6702.597844129173, 6738.797836064926, 6859.725610975505, 11503.884961150281, 11950.46222919988, 11955.282683039046, 12041.578544750892, 12141.392930353624, 11839.348835814113, 12115.575954841539, 12340.0, 12410.317432541297, 12413.255204687748, 9138.954305228432, 9157.77105572366, 9352.29857760657, 9358.362286599682, 9370.578323975575, 10176.949115254376, 10219.693409197736, 10279.691609251735, 10289.228307876789, 10302.896971030494, 8876.911230887867, 8999.335123002265, 9061.773455663397, 9070.727878163665, 9241.399309044891, 8909.643614255358, 8915.168070794016, 8950.060243674321, 9089.909100908906, 9096.9538503073, 7599.88600171009, 7712.691492340244, 7764.767056988299, 7770.0, 7774.766756997299, 4803.615710743063, 5663.9716801415725, 5666.801661941812, 5737.540996720336, 5845.386234445322, 5075.0, 5869.119632055226, 5980.671063091571, 6005.969970150121, 6053.75784968614], "value": 5032.357836678191, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.73310419247827, 367.762792998516, 369.48641388470014, 385.57586654679847, 389.77003567894934, 5293.602979776518, 5350.849567343021, 5367.973160134194, 5383.277351247598, 5408.6484378515415, 3997.7001724870606, 4450.799714012869, 4492.191405547001, 4611.446626404836, 5246.554042906358, 3686.926261474769, 3732.738708290414, 3832.846686132565, 3866.975251558339, 4078.3882417637296, 3441.4321636929876, 4272.423222864904, 4315.158544083889, 4325.956740432603, 4355.170828252141, 3608.600280813256, 4305.117450922569, 4313.956860431387, 4320.8703738887725, 4340.327249276367, 4054.6958978076614, 4244.983632774438, 4250.128723611652, 4282.678799090049, 4320.546342634009, 3582.874599389009, 3658.414653655429, 3774.8490060397553, 3840.5213992612767, 3949.308870947573, 4103.701926920904, 4768.904621907543, 4918.991606720614, 4925.931108934256, 5058.140116180258, 4602.895305126745, 4673.0, 4683.953160468386, 5014.420457555858, 5048.570871475929, 4939.851804445872, 5577.079781836032, 5614.831555053355, 5632.915506267409, 5671.517920976722, 3689.8377011241373, 4020.9344523701243, 4101.323281658522, 4289.806958686867, 4478.753668548228, 5717.742701578439, 5965.673387378883, 5982.4914882234625, 6039.429748265438, 6063.514918806485, 3932.4691166692132, 4108.226946810891, 4511.811771290922, 4581.473130590025, 4584.15193189261, 3833.5399752029934, 4192.685548583808, 4652.767361631905, 4700.576948074689, 4719.480857105716, 4132.504099508018, 4866.31871537985, 4894.99652571222, 4987.825426110068, 5026.396832380065, 5106.591472682177, 5211.140161873324, 5562.749676264578, 5591.4558875711455, 5597.0, 1321.894248460121, 1361.006465280331, 1401.0752903083915, 1451.1293224065687, 1567.4169089219743, 1000.8598796168542, 1014.9801894230428, 1044.6552637629563, 1173.6889724223088, 1187.7386974865515, 4418.491873434532, 4500.324951257272, 4754.264693386958, 4840.661153719206, 5081.814819627596, 5203.531682148625, 5214.59206014374, 5651.6043876928225, 5825.213611152784, 5825.427039773757, 4427.454213827063, 4616.676832621752, 4925.202301160122, 5107.208382700687, 5211.0234725836735, 2421.8304718669524, 2602.7787638050977, 2786.21985843964, 2930.1063175731606, 3087.922801929925, 5381.515663590296, 5381.811636592701, 5505.917411238835, 5813.941860581424, 6025.849353766103, 4567.520410356931, 4867.440244371872, 5814.244148260699, 5979.970100149471, 5994.880102397928, 5664.130836823838, 5894.646321220741, 5905.143754155623, 5905.881882362329, 6070.362611925861, 4995.550400463976, 5446.937847119773, 5699.699279669781, 5861.824145275648, 5891.970540147272, 5277.2875661785165, 5471.671699698031, 5570.916436253378, 5832.883342333214, 5838.511179649162, 5072.195853110167, 5137.842106315282, 5830.591858570029, 6048.90926636092, 6059.000529825235, 4041.4948131483566, 4532.864014079583, 4559.4756602989755, 4585.71599952014, 4642.605378542862, 4825.9034819302715, 5143.225587172419, 5768.94231057684, 5786.363500014911, 5788.479036886701, 5337.306150200449, 5536.114221724505, 5643.448051785792, 5647.915281270702, 5715.828525144252, 5184.300119483973, 5291.592325491969, 5563.58273129525, 5578.525825304732, 5644.6330988485615, 5094.312267843942, 5104.69371837691, 5309.946900530946, 5517.503424691797, 5541.251930989426, 5024.969881174424, 5300.70846103468, 5357.0, 5568.7399139659, 5667.631603945731, 4413.779311034371, 4724.385829842098, 5202.791888324576, 5450.784037417942, 5521.972390138024], "value": 4197.336592767095, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [704.7533363322838, 712.8146681862714, 762.7139822566537, 818.9754307370778, 834.7954751085983, 12917.418716157772, 16023.27895244714, 16114.0, 16135.757963630555, 16186.91906540467, 14310.642233944156, 15365.539033829004, 15379.769303460429, 15393.307301171446, 15412.152331621757, 798.6845196147518, 844.8605980013291, 879.9560021998874, 942.0155937045804, 946.5551190940247, 888.4669198480892, 909.05912380686, 940.3417607674655, 941.7127776028309, 950.3062764182151, 837.2841220756258, 998.1914649134225, 998.5656239535789, 1001.8747656542932, 1002.2382988928395, 836.4312267657959, 985.9260555458334, 990.2523594685966, 990.697837159666, 990.7027891632517, 728.3626826526789, 733.6881825224258, 738.5679377564131, 740.3558903753768, 747.8840779679158, 15810.762838557432, 15896.443624473088, 16226.513204603882, 16668.83331166685, 16915.492535223962, 13715.0, 13932.303384830719, 14006.22965736884, 14067.859321406757, 14260.786088208684, 10871.67384978452, 11436.0, 11573.479193436315, 11703.882961170364, 12096.697582560419, 4203.663706903471, 4211.789410529461, 4329.523752387235, 4387.312981488993, 4428.734275943454, 99332.52336168199, 102276.0, 102950.48524757403, 103619.48190259076, 104066.0, 10326.22553308505, 10338.431386273676, 10528.526216320284, 10594.947025264824, 11045.0, 16847.241874115694, 20845.68731469029, 21002.684959725615, 21067.367978960654, 21130.894345528173, 7356.227596102439, 7418.183999760022, 7489.400847932152, 7558.848823023509, 7668.5782281975025, 4084.0, 4138.565450627701, 4190.497140343117, 4199.958000420018, 4231.978840105779, 3235.53084802707, 3289.358575077885, 3316.4859446785304, 3324.700776930088, 3325.1022223999385, 595.3956733914993, 595.6217801695955, 609.20194545146, 613.7851751886803, 614.9538784591174, 463.39295522865154, 515.1577171324836, 524.1299442924727, 529.6186745543203, 558.7730854316275, 9457.38526995743, 9641.084097010773, 9674.951625241829, 9730.805383892282, 9775.90224097764, 510.1276816643581, 510.7114480318608, 533.3493138371181, 546.5327145290798, 549.1574975801558, 4010.258102251093, 4173.227952828736, 5046.39443266803, 5476.479734425223, 5484.561235101182, 82305.58847205725, 98256.0, 100959.48560771595, 102446.48776756218, 102895.0, 71203.28796711967, 74052.0, 82766.0, 82818.0, 84820.0, 74265.0, 74760.0, 75355.0, 75594.11014724566, 76145.0, 8120.903678003394, 10740.063229475423, 10853.782924341627, 10856.565737370416, 10947.416817423013, 39092.6090739089, 44784.43254486077, 44813.551864480934, 46934.765326174514, 47741.80645483891, 55952.720236398556, 63076.73846522952, 63235.051474227, 63456.41358966063, 64178.0, 11778.234414763356, 11934.164608477324, 12051.75896482083, 12563.246205227715, 12563.560275390317, 11386.54453821871, 14156.787648185491, 14270.857291426953, 14560.781588276397, 14576.052556583789, 13440.260785656883, 13622.727545449234, 13762.862371376157, 13791.51729689456, 13899.0, 13470.93264533671, 13474.66313342135, 13485.39315730814, 13693.794593081311, 13977.930110349384, 11625.825612615648, 13148.539801106916, 13473.932630336785, 13987.370568324654, 14038.505729900193, 10632.203843371128, 10838.891611083789, 10960.56157753681, 10980.176486763365, 11148.554057837595, 6939.892894253025, 9206.320668025059, 10540.209484288862, 10925.562977480811, 11205.271657342246], "value": 7342.3634915933835, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1595.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 121.0, 119.0, 99.0, 171.0, 178.0, 169.0, 120.0, 121.0, 121.0], "value": 132.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 151.0, 123.0, 184.0, 139.0, 109.0, 111.0, 113.0, 130.0, 113.0], "value": 134.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 209.0, 218.0, 221.0, 201.0, 195.0, 197.0, 195.0, 200.0, 193.0], "value": 202.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 64.0, 62.0, 85.0, 62.0, 66.0, 70.0, 85.0, 100.0, 86.0], "value": 76.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 71.0, 85.0, 78.0, 104.0, 103.0, 78.0, 88.0, 87.0, 107.0], "value": 88.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 90.0, 113.0, 100.0, 86.0, 87.0, 76.0, 77.0, 80.0, 129.0], "value": 92.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 92.0, 124.0, 94.0, 130.0, 157.0, 122.0, 122.0, 154.0, 97.0], "value": 119.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 107.0, 148.0, 146.0, 90.0, 93.0, 90.0, 90.0, 91.0, 90.0], "value": 105.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 66.0, 68.0, 67.0, 67.0, 67.0, 66.0, 67.0, 67.0], "value": 66.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 65.0, 60.0, 65.0, 64.0, 58.0, 58.0, 71.0, 87.0, 83.0], "value": 66.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 91.0, 87.0, 87.0, 88.0, 99.0, 112.0, 115.0, 74.0, 107.0], "value": 94.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 165.0, 140.0, 146.0, 151.0, 154.0, 140.0, 142.0, 188.0, 161.0], "value": 154.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 180.0, 159.0, 213.0, 178.0, 176.0, 173.0, 205.0, 159.0, 214.0], "value": 183.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 71.0, 82.0, 90.0, 68.0, 71.0, 71.0, 85.0, 88.0], "value": 76.4, "unit": "score"}]}]} 06:56:40 INFO - Return code: 0 06:56:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:56:40 ERROR - # TBPL SUCCESS # 06:56:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:56:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:56:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:56:40 INFO - 2017-03-08 06:56:40.384 screenresolution[1653:10679] starting screenresolution argv=screenresolution get 06:56:40 INFO - 2017-03-08 06:56:40.386 screenresolution[1653:10679] Display 0: 1600x1200x32@60 06:56:40 INFO - 2017-03-08 06:56:40.392 screenresolution[1654:10682] starting screenresolution argv=screenresolution list 06:56:40 INFO - Available Modes on Display 0 06:56:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:56:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:56:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:56:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:56:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:56:40 INFO - Intel Iris: 06:56:40 INFO - Chipset Model: Intel Iris 06:56:40 INFO - Type: GPU 06:56:40 INFO - Bus: Built-In 06:56:40 INFO - VRAM (Dynamic, Max): 1536 MB 06:56:40 INFO - Vendor: Intel (0x8086) 06:56:40 INFO - Device ID: 0x0a2e 06:56:40 INFO - Revision ID: 0x0009 06:56:40 INFO - Displays: 06:56:40 INFO - Display: 06:56:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:56:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:56:40 INFO - Display Serial Number: 1600x1200 60 06:56:40 INFO - Main Display: Yes 06:56:40 INFO - Mirror: Off 06:56:40 INFO - Online: Yes 06:56:40 INFO - Rotation: Supported 06:56:40 INFO - Return code: 0 06:56:40 INFO - Running post-action listener: _resource_record_post_action 06:56:40 INFO - [mozharness: 2017-03-08 14:56:40.632173Z] Finished run-tests step (success) 06:56:40 INFO - Running post-run listener: _resource_record_post_run 06:56:40 INFO - Total resource usage - Wall time: 1202s; CPU: 55.0%; Read bytes: 38296064; Write bytes: 514102272; Read time: 255; Write time: 1590 06:56:40 INFO - TinderboxPrint: CPU usage
54.6% 06:56:40 INFO - TinderboxPrint: I/O read bytes / time
38,296,064 / 255 06:56:40 INFO - TinderboxPrint: I/O write bytes / time
514,102,272 / 1,590 06:56:40 INFO - TinderboxPrint: CPU idle
2,182.4 (45.4%) 06:56:40 INFO - TinderboxPrint: CPU system
966.0 (20.1%) 06:56:40 INFO - TinderboxPrint: CPU user
1,661.3 (34.5%) 06:56:40 INFO - TinderboxPrint: Swap in / out
247,705,600 / 0 06:56:40 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 203737600; Write bytes: 203737088; Read time: 15572; Write time: 421 06:56:40 INFO - run-tests - Wall time: 1182s; CPU: 55.0%; Read bytes: 36403712; Write bytes: 299547648; Read time: 237; Write time: 1133 06:56:41 INFO - Running post-run listener: _upload_blobber_files 06:56:41 INFO - Blob upload gear active. 06:56:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:56:41 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 06:56:41 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'] 06:56:41 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 06:56:41 INFO - (blobuploader) - INFO - Open directory for files ... 06:56:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:56:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:56:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:56:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:56:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:56:42 INFO - (blobuploader) - INFO - Done attempting. 06:56:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:56:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:56:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:56:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:56:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:56:43 INFO - (blobuploader) - INFO - Done attempting. 06:56:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 06:56:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:56:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:56:44 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 06:56:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:56:44 INFO - (blobuploader) - INFO - Done attempting. 06:56:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:56:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:56:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:56:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:56:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:56:46 INFO - (blobuploader) - INFO - Done attempting. 06:56:46 INFO - (blobuploader) - INFO - Iteration through files over. 06:56:46 INFO - Return code: 0 06:56:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:56:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:56:46 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b2ef859eacb661caca538ec59732077bb88d8a253a18996208efd0cdadd5541df6373c49c4f01608f14cb245201b891de1e5bf5549ff91ad3d3309e024202071", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f7335aabd3e6ee2e4b42895d1183267a6aa42f6e1ba33ff6c87aeade5c0cee7f3125e94394ddfc3da8766d337921e460983e17c442bc196bdb45ce621129b8d0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/89a1314e5b149aba5ed43f8de914303286cfbb3aa69a1a958c0487ae97305647fd81211c2b735fe60dabf5c41a076c04826410218cc4826ba3daf93d2666b13d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7fe1b45fd2eeb3235bd0943688862b9c26b66d2cc15bdfad96fe093a8b859712577927fbd54d1ee3e59429f126154b6999ca3b435b862c2ddd77cb58dcbcfdfc"} 06:56:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:56:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:56:46 INFO - Contents: 06:56:46 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b2ef859eacb661caca538ec59732077bb88d8a253a18996208efd0cdadd5541df6373c49c4f01608f14cb245201b891de1e5bf5549ff91ad3d3309e024202071", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f7335aabd3e6ee2e4b42895d1183267a6aa42f6e1ba33ff6c87aeade5c0cee7f3125e94394ddfc3da8766d337921e460983e17c442bc196bdb45ce621129b8d0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/89a1314e5b149aba5ed43f8de914303286cfbb3aa69a1a958c0487ae97305647fd81211c2b735fe60dabf5c41a076c04826410218cc4826ba3daf93d2666b13d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7fe1b45fd2eeb3235bd0943688862b9c26b66d2cc15bdfad96fe093a8b859712577927fbd54d1ee3e59429f126154b6999ca3b435b862c2ddd77cb58dcbcfdfc"} 06:56:46 INFO - Running post-run listener: copy_logs_to_upload_dir 06:56:46 INFO - Copying logs to upload dir... 06:56:46 INFO - mkdir: /builds/slave/test/build/upload/logs 06:56:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1284.465044 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-03-08 06:56:46.869478) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-08 06:56:46.872615) ========= 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.LuSU6p3Mjl/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.qbG2FDon3I/Listeners TMPDIR=/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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/b2ef859eacb661caca538ec59732077bb88d8a253a18996208efd0cdadd5541df6373c49c4f01608f14cb245201b891de1e5bf5549ff91ad3d3309e024202071", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f7335aabd3e6ee2e4b42895d1183267a6aa42f6e1ba33ff6c87aeade5c0cee7f3125e94394ddfc3da8766d337921e460983e17c442bc196bdb45ce621129b8d0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/89a1314e5b149aba5ed43f8de914303286cfbb3aa69a1a958c0487ae97305647fd81211c2b735fe60dabf5c41a076c04826410218cc4826ba3daf93d2666b13d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7fe1b45fd2eeb3235bd0943688862b9c26b66d2cc15bdfad96fe093a8b859712577927fbd54d1ee3e59429f126154b6999ca3b435b862c2ddd77cb58dcbcfdfc"} build_url:https://queue.taskcluster.net/v1/task/FWg_Z5jlQoe2ZyCzF7Jyxg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010823 build_url: 'https://queue.taskcluster.net/v1/task/FWg_Z5jlQoe2ZyCzF7Jyxg/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/b2ef859eacb661caca538ec59732077bb88d8a253a18996208efd0cdadd5541df6373c49c4f01608f14cb245201b891de1e5bf5549ff91ad3d3309e024202071", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f7335aabd3e6ee2e4b42895d1183267a6aa42f6e1ba33ff6c87aeade5c0cee7f3125e94394ddfc3da8766d337921e460983e17c442bc196bdb45ce621129b8d0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/89a1314e5b149aba5ed43f8de914303286cfbb3aa69a1a958c0487ae97305647fd81211c2b735fe60dabf5c41a076c04826410218cc4826ba3daf93d2666b13d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7fe1b45fd2eeb3235bd0943688862b9c26b66d2cc15bdfad96fe093a8b859712577927fbd54d1ee3e59429f126154b6999ca3b435b862c2ddd77cb58dcbcfdfc"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-08 06:56:46.908689) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 06:56:46.909249) ========= 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.LuSU6p3Mjl/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.qbG2FDon3I/Listeners TMPDIR=/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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.005118 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 06:56:46.960499) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-08 06:56:46.960991) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-08 06:56:46.961493) ========= ========= Total master_lag: 0.19 =========