builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0176 starttime: 1489067529.28 results: success (0) buildid: 20170309030216 builduid: 53ddcc78c897471691e249a9c58da4d6 revision: c40ca7a1bdd93632c6bdc5e23bd33d984d508b19 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-09 05:52:09.284970) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-09 05:52:09.285419) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-09 05:52:09.285711) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-09 05:52:09.310594) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-09 05:52:09.310918) ========= 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.6Eadmebxvx/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.WkfaLVBQ9A/Listeners TMPDIR=/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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-09 05:52:09-- 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% 33.6M=0s 2017-03-09 05:52:09 (33.6 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.088057 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-09 05:52:09.422458) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-09 05:52:09.422792) ========= 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.6Eadmebxvx/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.WkfaLVBQ9A/Listeners TMPDIR=/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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.020967 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-09 05:52:09.470330) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2017-03-09 05:52:09.470644) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c40ca7a1bdd93632c6bdc5e23bd33d984d508b19 --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 c40ca7a1bdd93632c6bdc5e23bd33d984d508b19 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.6Eadmebxvx/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.WkfaLVBQ9A/Listeners TMPDIR=/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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-09 05:52:09,556 truncating revision to first 12 chars 2017-03-09 05:52:09,556 Setting DEBUG logging. 2017-03-09 05:52:09,556 attempt 1/10 2017-03-09 05:52:09,556 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c40ca7a1bdd9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-09 05:52:11,775 unpacking tar archive at: mozilla-central-c40ca7a1bdd9/testing/mozharness/ program finished with exit code 0 elapsedTime=2.476993 ========= master_lag: 1.82 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2017-03-09 05:52:13.768126) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-09 05:52:13.768452) ========= script_repo_revision: c40ca7a1bdd93632c6bdc5e23bd33d984d508b19 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-09 05:52:13.768861) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-09 05:52:13.769125) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-09 05:52:13.790884) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-03-09 05:52:13.791471) ========= /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.6Eadmebxvx/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.WkfaLVBQ9A/Listeners TMPDIR=/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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 05:52:13 INFO - MultiFileLogger online at 20170309 05:52:13 in /builds/slave/test 05:52:13 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 05:52:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:52:14 INFO - {'append_to_log': False, 05:52:14 INFO - 'base_work_dir': '/builds/slave/test', 05:52:14 INFO - 'blob_upload_branch': 'Firefox', 05:52:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:52:14 INFO - 'branch': 'Firefox', 05:52:14 INFO - 'buildbot_json_path': 'buildprops.json', 05:52:14 INFO - 'config_files': ('talos/mac_config.py',), 05:52:14 INFO - 'default_actions': ('clobber', 05:52:14 INFO - 'read-buildbot-config', 05:52:14 INFO - 'download-and-extract', 05:52:14 INFO - 'populate-webroot', 05:52:14 INFO - 'create-virtualenv', 05:52:14 INFO - 'install', 05:52:14 INFO - 'run-tests'), 05:52:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:52:14 INFO - 'download_minidump_stackwalk': True, 05:52:14 INFO - 'download_symbols': 'ondemand', 05:52:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:52:14 INFO - 'tooltool.py': '/tools/tooltool.py', 05:52:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:52:14 INFO - '/tools/misc-python/virtualenv.py')}, 05:52:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:52:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:52:14 INFO - 'gecko_profile': False, 05:52:14 INFO - 'gecko_profile_interval': 0, 05:52:14 INFO - 'installer_path': 'installer.exe', 05:52:14 INFO - 'log_level': 'info', 05:52:14 INFO - 'log_name': 'talos', 05:52:14 INFO - 'log_to_console': True, 05:52:14 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:52:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:52:14 INFO - 'opt_config_files': (), 05:52:14 INFO - 'pip_index': False, 05:52:14 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:52:14 INFO - 'cmd': ('bash', 05:52:14 INFO - '-c', 05:52:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:52:14 INFO - 'enabled': True, 05:52:14 INFO - 'halt_on_failure': False, 05:52:14 INFO - 'name': 'check_screen_resolution'},), 05:52:14 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:52:14 INFO - 'cmd': ('bash', 05:52:14 INFO - '-c', 05:52:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:52:14 INFO - 'enabled': True, 05:52:14 INFO - 'halt_on_failure': False, 05:52:14 INFO - 'name': 'check_screen_resolution'},), 05:52:14 INFO - 'run_cmd_checks_enabled': True, 05:52:14 INFO - 'suite': 'dromaeojs-e10s', 05:52:14 INFO - 'system_bits': '32', 05:52:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:52:14 INFO - 'title': 't-yosemite-r7-0176', 05:52:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:52:14 INFO - 'use_talos_json': True, 05:52:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:52:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:52:14 INFO - 'work_dir': 'build'} 05:52:14 INFO - [mozharness: 2017-03-09 13:52:14.007049Z] Running clobber step. 05:52:14 INFO - Running pre-action listener: _resource_record_pre_action 05:52:14 INFO - Running main action method: clobber 05:52:14 INFO - rmtree: /builds/slave/test/build 05:52:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:52:15 INFO - Running post-action listener: _resource_record_post_action 05:52:15 INFO - [mozharness: 2017-03-09 13:52:15.791427Z] Finished clobber step (success) 05:52:15 INFO - [mozharness: 2017-03-09 13:52:15.791574Z] Running read-buildbot-config step. 05:52:15 INFO - Running pre-action listener: _resource_record_pre_action 05:52:15 INFO - Running main action method: read_buildbot_config 05:52:15 INFO - Using buildbot properties: 05:52:15 INFO - { 05:52:15 INFO - "project": "", 05:52:15 INFO - "product": "firefox", 05:52:15 INFO - "script_repo_revision": "production", 05:52:15 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 05:52:15 INFO - "repository": "", 05:52:15 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 05:52:15 INFO - "buildid": "20170309030216", 05:52:15 INFO - "stage_platform": "macosx64", 05:52:15 INFO - "basedir": "/builds/slave/test", 05:52:15 INFO - "nightly_build": "True", 05:52:15 INFO - "buildnumber": 107, 05:52:15 INFO - "slavename": "t-yosemite-r7-0176", 05:52:15 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 05:52:15 INFO - "platform": "yosemite_r7", 05:52:15 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:52:15 INFO - "branch": "mozilla-central", 05:52:15 INFO - "repo_path": "mozilla-central", 05:52:15 INFO - "revision": "c40ca7a1bdd93632c6bdc5e23bd33d984d508b19", 05:52:15 INFO - "pgo_build": "False", 05:52:15 INFO - "builduid": "53ddcc78c897471691e249a9c58da4d6", 05:52:15 INFO - "slavebuilddir": "test" 05:52:15 INFO - } 05:52:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/HodiXT-GSXqvSq42qHGX0A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 05:52:15 INFO - Running post-action listener: _resource_record_post_action 05:52:15 INFO - [mozharness: 2017-03-09 13:52:15.795081Z] Finished read-buildbot-config step (success) 05:52:15 INFO - [mozharness: 2017-03-09 13:52:15.795197Z] Running download-and-extract step. 05:52:15 INFO - Running pre-action listener: _resource_record_pre_action 05:52:15 INFO - Running main action method: download_and_extract 05:52:15 INFO - mkdir: /builds/slave/test/build/tests 05:52:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:15 INFO - trying https://queue.taskcluster.net/v1/task/HodiXT-GSXqvSq42qHGX0A/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 05:52:15 INFO - Downloading https://queue.taskcluster.net/v1/task/HodiXT-GSXqvSq42qHGX0A/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 05:52:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HodiXT-GSXqvSq42qHGX0A/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 05:52:16 INFO - Downloaded 1199 bytes. 05:52:16 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 05:52:16 INFO - Using the following test package requirements: 05:52:16 INFO - {u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 05:52:16 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:52:16 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 05:52:16 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:52:16 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 05:52:16 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:52:16 INFO - u'jsshell-mac.zip'], 05:52:16 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:52:16 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 05:52:16 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 05:52:16 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:52:16 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 05:52:16 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:52:16 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 05:52:16 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:52:16 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 05:52:16 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:52:16 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 05:52:16 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:52:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HodiXT-GSXqvSq42qHGX0A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 05:52:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HodiXT-GSXqvSq42qHGX0A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:52:16 INFO - Fetch https://queue.taskcluster.net/v1/task/HodiXT-GSXqvSq42qHGX0A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 05:52:18 INFO - Expected file size: 51789109 05:52:18 INFO - Obtained file size: 51789109 05:52:34 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 05:52:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HodiXT-GSXqvSq42qHGX0A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 05:52:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HodiXT-GSXqvSq42qHGX0A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:52:34 INFO - Fetch https://queue.taskcluster.net/v1/task/HodiXT-GSXqvSq42qHGX0A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 05:52:36 INFO - Expected file size: 51789109 05:52:36 INFO - Obtained file size: 51789109 05:52:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HodiXT-GSXqvSq42qHGX0A/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 05:52:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HodiXT-GSXqvSq42qHGX0A/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:52:52 INFO - Fetch https://queue.taskcluster.net/v1/task/HodiXT-GSXqvSq42qHGX0A/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 05:52:53 INFO - Expected file size: 14404424 05:52:53 INFO - Obtained file size: 14404424 05:52:53 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')]} 05:52:53 INFO - trying https://queue.taskcluster.net/v1/task/HodiXT-GSXqvSq42qHGX0A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 05:52:53 INFO - Downloading https://queue.taskcluster.net/v1/task/HodiXT-GSXqvSq42qHGX0A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 05:52:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HodiXT-GSXqvSq42qHGX0A/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 05:52:55 INFO - Downloaded 75013985 bytes. 05:52:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HodiXT-GSXqvSq42qHGX0A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 05:52:55 INFO - mkdir: /builds/slave/test/properties 05:52:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:52:55 INFO - Writing to file /builds/slave/test/properties/build_url 05:52:55 INFO - Contents: 05:52:55 INFO - build_url:https://queue.taskcluster.net/v1/task/HodiXT-GSXqvSq42qHGX0A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 05:52:56 INFO - Running post-action listener: _resource_record_post_action 05:52:56 INFO - Running post-action listener: set_extra_try_arguments 05:52:56 INFO - [mozharness: 2017-03-09 13:52:56.164905Z] Finished download-and-extract step (success) 05:52:56 INFO - [mozharness: 2017-03-09 13:52:56.165060Z] Running populate-webroot step. 05:52:56 INFO - Running pre-action listener: _resource_record_pre_action 05:52:56 INFO - Running main action method: populate_webroot 05:52:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:52:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:52:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:52:56 INFO - '--tppagecycles', 05:52:56 INFO - '7'], 05:52:56 INFO - 'tests': ['tsvgm']}}, 05:52:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:52:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:52:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:52:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:52:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:52:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:52:56 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:52:56 INFO - 'talos_options': ['--disable-e10s'], 05:52:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:52:56 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:52:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:52:56 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:52:56 INFO - 'talos_options': ['--disable-e10s'], 05:52:56 INFO - 'tests': ['damp', 'tps']}, 05:52:56 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:52:56 INFO - 'tests': ['damp', 'tps']}, 05:52:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:52:56 INFO - 'tests': ['dromaeo_dom']}, 05:52:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:52:56 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:52:56 INFO - 'tests': ['basic_compositor_video']}, 05:52:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:52:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:52:56 INFO - 'tests': ['a11yr', 05:52:56 INFO - 'ts_paint', 05:52:56 INFO - 'tpaint', 05:52:56 INFO - 'sessionrestore', 05:52:56 INFO - 'sessionrestore_no_auto_restore', 05:52:56 INFO - 'tabpaint']}, 05:52:56 INFO - 'other-e10s': {'tests': ['a11yr', 05:52:56 INFO - 'ts_paint', 05:52:56 INFO - 'tpaint', 05:52:56 INFO - 'sessionrestore', 05:52:56 INFO - 'sessionrestore_no_auto_restore', 05:52:56 INFO - 'tabpaint']}, 05:52:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:52:56 INFO - 'ts_paint', 05:52:56 INFO - 'tpaint', 05:52:56 INFO - 'sessionrestore', 05:52:56 INFO - 'sessionrestore_no_auto_restore', 05:52:56 INFO - 'tabpaint']}, 05:52:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:52:56 INFO - 'ts_paint', 05:52:56 INFO - 'tpaint', 05:52:56 INFO - 'sessionrestore', 05:52:56 INFO - 'sessionrestore_no_auto_restore', 05:52:56 INFO - 'tabpaint']}, 05:52:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:52:56 INFO - 'tests': ['a11yr', 05:52:56 INFO - 'ts_paint', 05:52:56 INFO - 'tpaint', 05:52:56 INFO - 'sessionrestore', 05:52:56 INFO - 'sessionrestore_no_auto_restore', 05:52:56 INFO - 'tabpaint']}, 05:52:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:52:56 INFO - 'tests': ['a11yr', 05:52:56 INFO - 'ts_paint', 05:52:56 INFO - 'tpaint', 05:52:56 INFO - 'sessionrestore', 05:52:56 INFO - 'sessionrestore_no_auto_restore', 05:52:56 INFO - 'tabpaint']}, 05:52:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:52:56 INFO - 'tests': ['tsvgx', 05:52:56 INFO - 'tsvgr_opacity', 05:52:56 INFO - 'tart', 05:52:56 INFO - 'tscrollx', 05:52:56 INFO - 'cart', 05:52:56 INFO - 'tsvg_static']}, 05:52:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:52:56 INFO - 'tsvgr_opacity', 05:52:56 INFO - 'tart', 05:52:56 INFO - 'tscrollx', 05:52:56 INFO - 'cart', 05:52:56 INFO - 'tsvg_static']}, 05:52:56 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:52:56 INFO - 'talos_options': ['--disable-e10s'], 05:52:56 INFO - 'tests': ['tp5o']}, 05:52:56 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:52:56 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:52:56 INFO - 'talos_options': ['--disable-e10s', 05:52:56 INFO - '--xperf_path', 05:52:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:52:56 INFO - 'tests': ['tp5n']}, 05:52:56 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:52:56 INFO - 'talos_options': ['--xperf_path', 05:52:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:52:56 INFO - 'tests': ['tp5n']}}, 05:52:56 INFO - 'talos.zip': {'path': '', 05:52:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:52:56 INFO - Running post-action listener: _resource_record_post_action 05:52:56 INFO - [mozharness: 2017-03-09 13:52:56.183169Z] Finished populate-webroot step (success) 05:52:56 INFO - [mozharness: 2017-03-09 13:52:56.183290Z] Running create-virtualenv step. 05:52:56 INFO - Running pre-action listener: _resource_record_pre_action 05:52:56 INFO - Running main action method: create_virtualenv 05:52:56 INFO - Creating virtualenv /builds/slave/test/build/venv 05:52:56 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 05:52:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:52:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:52:56 INFO - Using real prefix '/tools/python27' 05:52:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:52:57 INFO - Installing distribute.............................................................................................................................................................................................done. 05:52:59 INFO - Installing pip.................done. 05:52:59 INFO - Return code: 0 05:52:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:52:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:53:00 INFO - Reading from file tmpfile_stdout 05:53:00 INFO - Output received: 05:53:00 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) 05:53:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:53:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f6ffb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f702768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ef1d65bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4ddd30>, '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 0x10f404db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4d2be8>, '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.6Eadmebxvx/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.WkfaLVBQ9A/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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 05:53:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:53:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:53:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6Eadmebxvx/Render', 05:53:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:53:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:53:00 INFO - 'HOME': '/Users/cltbld', 05:53:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:53:00 INFO - 'LOGNAME': 'cltbld', 05:53:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:00 INFO - 'MOZ_NO_REMOTE': '1', 05:53:00 INFO - 'NO_EM_RESTART': '1', 05:53:00 INFO - 'PAGER': '/bin/cat', 05:53:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:53:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:00 INFO - 'PWD': '/builds/slave/test', 05:53:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:53:00 INFO - 'SHELL': '/bin/bash', 05:53:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WkfaLVBQ9A/Listeners', 05:53:00 INFO - 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/', 05:53:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:53:00 INFO - 'USER': 'cltbld', 05:53:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:53:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:53:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:00 INFO - 'XPC_FLAGS': '0x0', 05:53:00 INFO - 'XPC_SERVICE_NAME': '0', 05:53:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:53:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:00 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 05:53:00 INFO - Cleaning up... 05:53:00 INFO - Return code: 0 05:53:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:53:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f6ffb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f702768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ef1d65bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4ddd30>, '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 0x10f404db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4d2be8>, '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.6Eadmebxvx/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.WkfaLVBQ9A/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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 05:53:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:53:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:53:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6Eadmebxvx/Render', 05:53:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:53:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:53:00 INFO - 'HOME': '/Users/cltbld', 05:53:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:53:00 INFO - 'LOGNAME': 'cltbld', 05:53:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:00 INFO - 'MOZ_NO_REMOTE': '1', 05:53:00 INFO - 'NO_EM_RESTART': '1', 05:53:00 INFO - 'PAGER': '/bin/cat', 05:53:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:53:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:00 INFO - 'PWD': '/builds/slave/test', 05:53:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:53:00 INFO - 'SHELL': '/bin/bash', 05:53:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WkfaLVBQ9A/Listeners', 05:53:00 INFO - 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/', 05:53:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:53:00 INFO - 'USER': 'cltbld', 05:53:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:53:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:53:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:00 INFO - 'XPC_FLAGS': '0x0', 05:53:00 INFO - 'XPC_SERVICE_NAME': '0', 05:53:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:53:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:00 INFO - Downloading/unpacking psutil>=3.1.1 05:53:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:53:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:53:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:53:04 INFO - Installing collected packages: psutil 05:53:04 INFO - Running setup.py install for psutil 05:53:04 INFO - building 'psutil._psutil_osx' extension 05:53:04 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 05:53:04 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 05:53:04 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 05:53:04 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 05:53:04 INFO - building 'psutil._psutil_posix' extension 05:53:04 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 05:53:05 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:53:05 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:53:05 INFO - ^ 05:53:05 INFO - 1 warning generated. 05:53:05 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 05:53:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:53:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:53:05 INFO - Successfully installed psutil 05:53:05 INFO - Cleaning up... 05:53:05 INFO - Return code: 0 05:53:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:53:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:06 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 0x10f6ffb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f702768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ef1d65bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4ddd30>, '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 0x10f404db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4d2be8>, '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.6Eadmebxvx/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.WkfaLVBQ9A/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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 05:53:06 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 05:53:06 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 05:53:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6Eadmebxvx/Render', 05:53:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:53:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:53:06 INFO - 'HOME': '/Users/cltbld', 05:53:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:53:06 INFO - 'LOGNAME': 'cltbld', 05:53:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:06 INFO - 'MOZ_NO_REMOTE': '1', 05:53:06 INFO - 'NO_EM_RESTART': '1', 05:53:06 INFO - 'PAGER': '/bin/cat', 05:53:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:53:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:06 INFO - 'PWD': '/builds/slave/test', 05:53:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:53:06 INFO - 'SHELL': '/bin/bash', 05:53:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WkfaLVBQ9A/Listeners', 05:53:06 INFO - 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/', 05:53:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:53:06 INFO - 'USER': 'cltbld', 05:53:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:53:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:53:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:06 INFO - 'XPC_FLAGS': '0x0', 05:53:06 INFO - 'XPC_SERVICE_NAME': '0', 05:53:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:53:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:53:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:53:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:53:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:53:09 INFO - Installing collected packages: mozsystemmonitor 05:53:09 INFO - Running setup.py install for mozsystemmonitor 05:53:09 INFO - Successfully installed mozsystemmonitor 05:53:09 INFO - Cleaning up... 05:53:09 INFO - Return code: 0 05:53:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:53: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')]} 05:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:10 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 0x10f6ffb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f702768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ef1d65bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4ddd30>, '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 0x10f404db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4d2be8>, '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.6Eadmebxvx/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.WkfaLVBQ9A/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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 05:53:10 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 05:53:10 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 05:53:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6Eadmebxvx/Render', 05:53:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:53:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:53:10 INFO - 'HOME': '/Users/cltbld', 05:53:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:53:10 INFO - 'LOGNAME': 'cltbld', 05:53:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:10 INFO - 'MOZ_NO_REMOTE': '1', 05:53:10 INFO - 'NO_EM_RESTART': '1', 05:53:10 INFO - 'PAGER': '/bin/cat', 05:53:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:53:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:10 INFO - 'PWD': '/builds/slave/test', 05:53:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:53:10 INFO - 'SHELL': '/bin/bash', 05:53:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WkfaLVBQ9A/Listeners', 05:53:10 INFO - 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/', 05:53:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:53:10 INFO - 'USER': 'cltbld', 05:53:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:53:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:53:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:10 INFO - 'XPC_FLAGS': '0x0', 05:53:10 INFO - 'XPC_SERVICE_NAME': '0', 05:53:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:53:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:10 INFO - Downloading/unpacking jsonschema==2.5.1 05:53:10 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 05:53:10 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 05:53:10 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 05:53:10 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 05:53:10 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 05:53:10 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 05:53:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:53:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:53:12 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 05:53:12 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 05:53:12 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 05:53:12 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 05:53:12 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 05:53:12 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 05:53:13 INFO - Downloading functools32-3.2.3-2.tar.gz 05:53:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:53:13 INFO - warning: no files found matching '*.txt' 05:53:13 INFO - no previously-included directories found matching 'build' 05:53:13 INFO - no previously-included directories found matching 'dist' 05:53:13 INFO - no previously-included directories found matching '.git*' 05:53:13 INFO - Installing collected packages: jsonschema, functools32 05:53:13 INFO - Running setup.py install for functools32 05:53:13 INFO - warning: no files found matching '*.txt' 05:53:13 INFO - no previously-included directories found matching 'build' 05:53:13 INFO - no previously-included directories found matching 'dist' 05:53:13 INFO - no previously-included directories found matching '.git*' 05:53:13 INFO - Successfully installed jsonschema functools32 05:53:13 INFO - Cleaning up... 05:53:13 INFO - Return code: 0 05:53:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:53:13 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')]} 05:53:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:13 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')]} 05:53:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:13 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 0x10f6ffb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f702768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ef1d65bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4ddd30>, '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 0x10f404db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4d2be8>, '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.6Eadmebxvx/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.WkfaLVBQ9A/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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 05:53:13 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 05:53:13 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 05:53:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6Eadmebxvx/Render', 05:53:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:53:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:53:13 INFO - 'HOME': '/Users/cltbld', 05:53:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:53:13 INFO - 'LOGNAME': 'cltbld', 05:53:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:13 INFO - 'MOZ_NO_REMOTE': '1', 05:53:13 INFO - 'NO_EM_RESTART': '1', 05:53:13 INFO - 'PAGER': '/bin/cat', 05:53:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:53:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:13 INFO - 'PWD': '/builds/slave/test', 05:53:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:53:13 INFO - 'SHELL': '/bin/bash', 05:53:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WkfaLVBQ9A/Listeners', 05:53:13 INFO - 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/', 05:53:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:53:13 INFO - 'USER': 'cltbld', 05:53:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:53:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:53:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:13 INFO - 'XPC_FLAGS': '0x0', 05:53:13 INFO - 'XPC_SERVICE_NAME': '0', 05:53:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:53:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:53:14 INFO - Cleaning up... 05:53:14 INFO - Return code: 0 05:53:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:53: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')]} 05:53:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53: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')]} 05:53:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53: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', '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 0x10f6ffb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f702768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ef1d65bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4ddd30>, '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 0x10f404db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4d2be8>, '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.6Eadmebxvx/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.WkfaLVBQ9A/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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 05:53: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:53: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 blobuploader==1.2.4 05:53:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6Eadmebxvx/Render', 05:53:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:53:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:53:14 INFO - 'HOME': '/Users/cltbld', 05:53:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:53:14 INFO - 'LOGNAME': 'cltbld', 05:53:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:14 INFO - 'MOZ_NO_REMOTE': '1', 05:53:14 INFO - 'NO_EM_RESTART': '1', 05:53:14 INFO - 'PAGER': '/bin/cat', 05:53:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:53:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:14 INFO - 'PWD': '/builds/slave/test', 05:53:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:53:14 INFO - 'SHELL': '/bin/bash', 05:53:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WkfaLVBQ9A/Listeners', 05:53:14 INFO - 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/', 05:53:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:53:14 INFO - 'USER': 'cltbld', 05:53:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:53:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:53:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:14 INFO - 'XPC_FLAGS': '0x0', 05:53:14 INFO - 'XPC_SERVICE_NAME': '0', 05:53:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:53:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:14 INFO - Downloading/unpacking blobuploader==1.2.4 05:53: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 05:53: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 05:53: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 05:53: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 05:53: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 05:53: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 05:53:16 INFO - Downloading blobuploader-1.2.4.tar.gz 05:53:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:53:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:53:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:53:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:53:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:18 INFO - Downloading docopt-0.6.1.tar.gz 05:53:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:53:18 INFO - Installing collected packages: blobuploader, requests, docopt 05:53:18 INFO - Running setup.py install for blobuploader 05:53:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:53:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:53:18 INFO - Running setup.py install for requests 05:53:18 INFO - Running setup.py install for docopt 05:53:19 INFO - Successfully installed blobuploader requests docopt 05:53:19 INFO - Cleaning up... 05:53:19 INFO - Return code: 0 05:53:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:53:19 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')]} 05:53:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:19 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')]} 05:53:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:19 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 0x10f6ffb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f702768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ef1d65bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4ddd30>, '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 0x10f404db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4d2be8>, '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.6Eadmebxvx/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.WkfaLVBQ9A/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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 05:53:19 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 05:53:19 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 05:53:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6Eadmebxvx/Render', 05:53:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:53:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:53:19 INFO - 'HOME': '/Users/cltbld', 05:53:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:53:19 INFO - 'LOGNAME': 'cltbld', 05:53:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:19 INFO - 'MOZ_NO_REMOTE': '1', 05:53:19 INFO - 'NO_EM_RESTART': '1', 05:53:19 INFO - 'PAGER': '/bin/cat', 05:53:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:53:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:19 INFO - 'PWD': '/builds/slave/test', 05:53:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:53:19 INFO - 'SHELL': '/bin/bash', 05:53:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WkfaLVBQ9A/Listeners', 05:53:19 INFO - 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/', 05:53:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:53:19 INFO - 'USER': 'cltbld', 05:53:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:53:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:53:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:19 INFO - 'XPC_FLAGS': '0x0', 05:53:19 INFO - 'XPC_SERVICE_NAME': '0', 05:53:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:53:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:53:19 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-UI5q4S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:53:19 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-HiKmUd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:53:19 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-tFxafi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:53:19 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-8Hg6Df-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:53:19 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-mQE9ir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:53:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:53:20 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-2AqBEt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:53:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:53:20 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-a17Ug4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:53:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:53:20 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-C_ZQiT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:53:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:53:20 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-c0XfFv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:53:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:53:20 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-YQ5DdA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:53:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:53:20 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-kd8uwM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:53:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:53:20 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-GUiyys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:53:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:53:20 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-6n8Bl1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:53:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:53:20 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-P1GTDR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:53:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:53:20 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-ezPSkt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:53:21 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-A7xyAd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:53:21 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-E2kVRC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:53:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:53:21 INFO - Running setup.py install for manifestparser 05:53:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:53:21 INFO - Running setup.py install for mozcrash 05:53:21 INFO - Running setup.py install for mozdebug 05:53:21 INFO - Running setup.py install for mozdevice 05:53:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:53:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:53:21 INFO - Running setup.py install for mozfile 05:53:22 INFO - Running setup.py install for mozhttpd 05:53:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:53:22 INFO - Running setup.py install for mozinfo 05:53:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:53:22 INFO - Running setup.py install for mozInstall 05:53:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:53:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:53:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:53:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:53:22 INFO - Running setup.py install for mozleak 05:53:22 INFO - Running setup.py install for mozlog 05:53:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:53:22 INFO - Running setup.py install for moznetwork 05:53:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:53:22 INFO - Running setup.py install for mozprocess 05:53:23 INFO - Running setup.py install for mozprofile 05:53:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:53:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:53:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:53:23 INFO - Running setup.py install for mozrunner 05:53:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:53:23 INFO - Running setup.py install for mozscreenshot 05:53:23 INFO - Running setup.py install for moztest 05:53:23 INFO - Running setup.py install for mozversion 05:53:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:53:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:53:23 INFO - Cleaning up... 05:53:23 INFO - Return code: 0 05:53:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:53:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:23 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 0x10f6ffb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f702768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ef1d65bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4ddd30>, '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 0x10f404db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4d2be8>, '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.6Eadmebxvx/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.WkfaLVBQ9A/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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 05:53:23 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 05:53:23 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 05:53:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6Eadmebxvx/Render', 05:53:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:53:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:53:23 INFO - 'HOME': '/Users/cltbld', 05:53:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:53:23 INFO - 'LOGNAME': 'cltbld', 05:53:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:23 INFO - 'MOZ_NO_REMOTE': '1', 05:53:23 INFO - 'NO_EM_RESTART': '1', 05:53:23 INFO - 'PAGER': '/bin/cat', 05:53:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:53:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:23 INFO - 'PWD': '/builds/slave/test', 05:53:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:53:23 INFO - 'SHELL': '/bin/bash', 05:53:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WkfaLVBQ9A/Listeners', 05:53:23 INFO - 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/', 05:53:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:53:23 INFO - 'USER': 'cltbld', 05:53:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:53:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:53:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:23 INFO - 'XPC_FLAGS': '0x0', 05:53:23 INFO - 'XPC_SERVICE_NAME': '0', 05:53:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:53:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:53:24 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-vVv0Mm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:53:24 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)) 05:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:53:24 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-jNIMYc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:53:24 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)) 05:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:53:24 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-wxgonU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:53:24 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)) 05:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:53:24 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-iOUJmv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:53:24 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)) 05:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:53:24 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-E_uUph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:53:24 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)) 05:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:53:24 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-AYHmE0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:53:24 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)) 05:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:53:24 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-RhOfoI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:53:24 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)) 05:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:53:24 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-Us5QaW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:53:25 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)) 05:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:53:25 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-ud5g07-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:53:25 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)) 05:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:53:25 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-9I7Xdk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:53:25 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)) 05:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:53:25 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-iim36_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:53:25 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)) 05:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:53:25 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-MBNz7E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:53:25 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)) 05:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:53:25 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-MXSXXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:53:25 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)) 05:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:53:25 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-nQLDJK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:53:25 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)) 05:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:53:25 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-wj8PiC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:53:25 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)) 05:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:53:25 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-VWTRN1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:53:25 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)) 05:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:53:25 INFO - Running setup.py (path:/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/pip-1aaVoN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:53:25 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)) 05:53:25 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)) 05:53:25 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)) 05:53:25 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)) 05:53:25 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)) 05:53:25 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)) 05:53:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:53: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 05:53: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 05:53:26 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 05:53:26 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 05:53:26 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 05:53:26 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 05:53:28 INFO - Downloading blessings-1.6.tar.gz 05:53:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:53:28 INFO - Installing collected packages: blessings 05:53:28 INFO - Running setup.py install for blessings 05:53:28 INFO - Successfully installed blessings 05:53:28 INFO - Cleaning up... 05:53:28 INFO - Return code: 0 05:53:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:53:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:53:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:53:29 INFO - Reading from file tmpfile_stdout 05:53:29 INFO - Current package versions: 05:53:29 INFO - blessings == 1.6 05:53:29 INFO - blobuploader == 1.2.4 05:53:29 INFO - docopt == 0.6.1 05:53:29 INFO - functools32 == 3.2.3-2 05:53:29 INFO - jsonschema == 2.5.1 05:53:29 INFO - manifestparser == 1.1 05:53:29 INFO - mozInstall == 1.12 05:53:29 INFO - mozcrash == 1.0 05:53:29 INFO - mozdebug == 0.1 05:53:29 INFO - mozdevice == 0.49 05:53:29 INFO - mozfile == 1.2 05:53:29 INFO - mozhttpd == 0.7 05:53:29 INFO - mozinfo == 0.9 05:53:29 INFO - mozleak == 0.1 05:53:29 INFO - mozlog == 3.4 05:53:29 INFO - moznetwork == 0.27 05:53:29 INFO - mozprocess == 0.25 05:53:29 INFO - mozprofile == 0.28 05:53:29 INFO - mozrunner == 6.13 05:53:29 INFO - mozscreenshot == 0.1 05:53:29 INFO - mozsystemmonitor == 0.3 05:53:29 INFO - moztest == 0.8 05:53:29 INFO - mozversion == 1.4 05:53:29 INFO - psutil == 3.1.1 05:53:29 INFO - requests == 1.2.3 05:53:29 INFO - wsgiref == 0.1.2 05:53:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:53:29 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')]} 05:53:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:29 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')]} 05:53:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:29 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 0x10f6ffb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f702768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ef1d65bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4ddd30>, '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 0x10f404db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4d2be8>, '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.6Eadmebxvx/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.WkfaLVBQ9A/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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 05:53:29 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 05:53:29 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 05:53:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6Eadmebxvx/Render', 05:53:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:53:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:53:29 INFO - 'HOME': '/Users/cltbld', 05:53:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:53:29 INFO - 'LOGNAME': 'cltbld', 05:53:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:29 INFO - 'MOZ_NO_REMOTE': '1', 05:53:29 INFO - 'NO_EM_RESTART': '1', 05:53:29 INFO - 'PAGER': '/bin/cat', 05:53:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:53:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:29 INFO - 'PWD': '/builds/slave/test', 05:53:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:53:29 INFO - 'SHELL': '/bin/bash', 05:53:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WkfaLVBQ9A/Listeners', 05:53:29 INFO - 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/', 05:53:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:53:29 INFO - 'USER': 'cltbld', 05:53:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:53:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:53:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:29 INFO - 'XPC_FLAGS': '0x0', 05:53:29 INFO - 'XPC_SERVICE_NAME': '0', 05:53:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:53:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:29 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)) 05:53:29 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)) 05:53:29 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)) 05:53:29 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)) 05:53:29 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)) 05:53:29 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)) 05:53:29 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)) 05:53:29 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)) 05:53:29 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)) 05:53:29 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)) 05:53:29 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)) 05:53:29 INFO - Cleaning up... 05:53:29 INFO - Return code: 0 05:53:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:53:29 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')]} 05:53:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:29 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')]} 05:53:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:29 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 0x10f6ffb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f702768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ef1d65bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f4ddd30>, '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 0x10f404db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4d2be8>, '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.6Eadmebxvx/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.WkfaLVBQ9A/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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 05:53:29 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 05:53:29 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 05:53:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6Eadmebxvx/Render', 05:53:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:53:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:53:29 INFO - 'HOME': '/Users/cltbld', 05:53:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:53:29 INFO - 'LOGNAME': 'cltbld', 05:53:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:29 INFO - 'MOZ_NO_REMOTE': '1', 05:53:29 INFO - 'NO_EM_RESTART': '1', 05:53:29 INFO - 'PAGER': '/bin/cat', 05:53:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:53:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:29 INFO - 'PWD': '/builds/slave/test', 05:53:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:53:29 INFO - 'SHELL': '/bin/bash', 05:53:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WkfaLVBQ9A/Listeners', 05:53:29 INFO - 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/', 05:53:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:53:29 INFO - 'USER': 'cltbld', 05:53:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:53:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:53:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:29 INFO - 'XPC_FLAGS': '0x0', 05:53:29 INFO - 'XPC_SERVICE_NAME': '0', 05:53:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:53:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:53:29 INFO - Cleaning up... 05:53:29 INFO - Return code: 0 05:53:29 INFO - Running post-action listener: _resource_record_post_action 05:53:29 INFO - Running post-action listener: _start_resource_monitoring 05:53:29 INFO - Starting resource monitoring. 05:53:29 INFO - [mozharness: 2017-03-09 13:53:29.797675Z] Finished create-virtualenv step (success) 05:53:29 INFO - [mozharness: 2017-03-09 13:53:29.798483Z] Running install step. 05:53:29 INFO - Running pre-action listener: _resource_record_pre_action 05:53:29 INFO - Running main action method: install 05:53:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:53:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:53:30 INFO - Reading from file tmpfile_stdout 05:53:30 INFO - Detecting whether we're running mozinstall >=1.0... 05:53:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:53:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:53:30 INFO - Reading from file tmpfile_stdout 05:53:30 INFO - Output received: 05:53:30 INFO - Usage: mozinstall [options] installer 05:53:30 INFO - Options: 05:53:30 INFO - -h, --help show this help message and exit 05:53:30 INFO - -d DEST, --destination=DEST 05:53:30 INFO - Directory to install application into. [default: 05:53:30 INFO - "/builds/slave/test"] 05:53:30 INFO - --app=APP Application being installed. [default: firefox] 05:53:30 INFO - mkdir: /builds/slave/test/build/application 05:53:30 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'] 05:53:30 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 05:53:50 INFO - Reading from file tmpfile_stdout 05:53:50 INFO - Output received: 05:53:50 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:53:50 INFO - Running post-action listener: _resource_record_post_action 05:53:50 INFO - [mozharness: 2017-03-09 13:53:50.336306Z] Finished install step (success) 05:53:50 INFO - [mozharness: 2017-03-09 13:53:50.336448Z] Running run-tests step. 05:53:50 INFO - Running pre-action listener: _resource_record_pre_action 05:53:50 INFO - Running main action method: run_tests 05:53:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:53:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:53:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:53:50 INFO - 2017-03-09 05:53:50.350 screenresolution[1892:21136] starting screenresolution argv=screenresolution get 05:53:50 INFO - 2017-03-09 05:53:50.353 screenresolution[1892:21136] Display 0: 1600x1200x32@60 05:53:50 INFO - 2017-03-09 05:53:50.359 screenresolution[1893:21138] starting screenresolution argv=screenresolution list 05:53:50 INFO - Available Modes on Display 0 05:53:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:53:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:53:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:53:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:53:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:53:50 INFO - Intel Iris: 05:53:50 INFO - Chipset Model: Intel Iris 05:53:50 INFO - Type: GPU 05:53:50 INFO - Bus: Built-In 05:53:50 INFO - VRAM (Dynamic, Max): 1536 MB 05:53:50 INFO - Vendor: Intel (0x8086) 05:53:50 INFO - Device ID: 0x0a2e 05:53:50 INFO - Revision ID: 0x0009 05:53:50 INFO - Displays: 05:53:50 INFO - Display: 05:53:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:53:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:53:50 INFO - Display Serial Number: 1600x1200 60 05:53:50 INFO - Main Display: Yes 05:53:50 INFO - Mirror: Off 05:53:50 INFO - Online: Yes 05:53:50 INFO - Rotation: Supported 05:53:50 INFO - Return code: 0 05:53:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:53:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:53:50 INFO - Python 2.7.3 05:53:50 INFO - Return code: 0 05:53:50 INFO - grabbing minidump binary from tooltool 05:53:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:50 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 0x10f4ddd30>, '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 0x10f404db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4d2be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:53:50 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 05:53:50 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 05:53:50 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 05:53:50 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:53:50 INFO - Return code: 0 05:53:50 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:53:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:53:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:53:50 INFO - ENV: RUST_BACKTRACE is now 1 05:53:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:53:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:53:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HodiXT-GSXqvSq42qHGX0A/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0176', '--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 05:53:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HodiXT-GSXqvSq42qHGX0A/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0176 --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 05:53:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6Eadmebxvx/Render', 05:53:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:53:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:53:50 INFO - 'HOME': '/Users/cltbld', 05:53:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:53:50 INFO - 'LOGNAME': 'cltbld', 05:53:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:53:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:53:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:50 INFO - 'MOZ_NO_REMOTE': '1', 05:53:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:53:50 INFO - 'NO_EM_RESTART': '1', 05:53:50 INFO - 'PAGER': '/bin/cat', 05:53:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:53:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:50 INFO - 'PWD': '/builds/slave/test', 05:53:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:53:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:53:50 INFO - 'RUST_BACKTRACE': '1', 05:53:50 INFO - 'SHELL': '/bin/bash', 05:53:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WkfaLVBQ9A/Listeners', 05:53:50 INFO - 'TMPDIR': '/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/', 05:53:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:53:50 INFO - 'USER': 'cltbld', 05:53:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:53:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:53:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:50 INFO - 'XPC_FLAGS': '0x0', 05:53:50 INFO - 'XPC_SERVICE_NAME': '0', 05:53:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:53:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HodiXT-GSXqvSq42qHGX0A/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0176', '--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 05:53:50 INFO - mozversion application_buildid: 20170309030216 05:53:50 INFO - mozversion application_changeset: c40ca7a1bdd93632c6bdc5e23bd33d984d508b19 05:53:50 INFO - mozversion application_display_name: Nightly 05:53:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:53:50 INFO - mozversion application_name: Firefox 05:53:50 INFO - mozversion application_remotingname: firefox 05:53:50 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:53:50 INFO - mozversion application_vendor: Mozilla 05:53:50 INFO - mozversion application_version: 55.0a1 05:53:50 INFO - mozversion platform_buildid: 20170309030216 05:53:50 INFO - mozversion platform_changeset: c40ca7a1bdd93632c6bdc5e23bd33d984d508b19 05:53:50 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:53:50 INFO - mozversion platform_version: 55.0a1 05:53:50 INFO - using testdate: 1489067630 05:53:50 INFO - actual date: 1489067630 05:53:50 INFO - starting webserver on 'localhost:57531' 05:53:50 INFO - SUITE-START | Running 2 tests 05:53:50 INFO - TEST-START | dromaeo_css 05:53:50 INFO - operating with platform_type : mac_ 05:53:50 INFO - Initialising browser for dromaeo_css test... 05:53:50 INFO - TEST-INFO | started process 1903 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/tmpVkEC3_/profile http://localhost:57531/getInfo.html) 05:53:53 INFO - PROCESS | 1903 | 2017-03-09 05:53:53.990 plugin-container[1906:21315] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4a57, name = 'com.apple.tsm.portname' 05:53:53 INFO - PROCESS | 1903 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:53:53 INFO - PROCESS | 1903 | 2017-03-09 05:53:53.991 plugin-container[1906:21315] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x980b, name = 'com.apple.CFPasteboardClient' 05:53:53 INFO - PROCESS | 1903 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:53:53 INFO - PROCESS | 1903 | 2017-03-09 05:53:53.991 plugin-container[1906:21315] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:53:54 INFO - PROCESS | 1903 | __metrics Screen width/height:1600/1200 05:53:54 INFO - PROCESS | 1903 | colorDepth:24 05:53:54 INFO - PROCESS | 1903 | Browser inner width/height: 1024/689 05:53:54 INFO - PROCESS | 1903 | __metrics 05:53:54 ERROR - PROCESS | 1903 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3353: TypeError: this.tabs is undefined 05:53:54 INFO - TEST-INFO | 1903: exit 0 05:53:54 INFO - Browser initialized. 05:53:54 INFO - Running cycle 1/1 for dromaeo_css test... 05:53:54 INFO - TEST-INFO | started process 1907 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/tmpVkEC3_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:53:57 INFO - PROCESS | 1907 | 2017-03-09 05:53:57.457 plugin-container[1908:21453] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 05:53:57 INFO - PROCESS | 1907 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:53:57 INFO - PROCESS | 1907 | 2017-03-09 05:53:57.458 plugin-container[1908:21453] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9003, name = 'com.apple.CFPasteboardClient' 05:53:57 INFO - PROCESS | 1907 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:53:57 INFO - PROCESS | 1907 | 2017-03-09 05:53:57.458 plugin-container[1908:21453] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:54:07 INFO - PROCESS | 1907 | RSS: Main: 227549184 05:54:07 INFO - PROCESS | 1907 | 05:57:10 INFO - PROCESS | 1907 | Cycle 1(1): loaded http://localhost:57531/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57531/tests/dromaeo/cssquery-ext.html) 05:57:12 INFO - PROCESS | 1907 | RSS: Main: 250437632 05:57:12 INFO - PROCESS | 1907 | 05:58:55 INFO - PROCESS | 1907 | ************************* 05:58:55 INFO - PROCESS | 1907 | A coding exception was thrown and uncaught in a Task. 05:58:55 INFO - PROCESS | 1907 | 05:58:55 ERROR - PROCESS | 1907 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:58:55 INFO - PROCESS | 1907 | Full stack: 05:58:55 INFO - PROCESS | 1907 | ************************* 06:00:14 INFO - PROCESS | 1907 | Cycle 1(1): loaded http://localhost:57531/tests/dromaeo/cssquery-ext.html (next: http://localhost:57531/tests/dromaeo/cssquery-jquery.html) 06:00:15 INFO - PROCESS | 1907 | RSS: Main: 261550080 06:00:15 INFO - PROCESS | 1907 | 06:03:17 INFO - PROCESS | 1907 | Cycle 1(1): loaded http://localhost:57531/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57531/tests/dromaeo/cssquery-mootools.html) 06:03:18 INFO - PROCESS | 1907 | RSS: Main: 273354752 06:03:18 INFO - PROCESS | 1907 | 06:06:20 INFO - PROCESS | 1907 | Cycle 1(1): loaded http://localhost:57531/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57531/tests/dromaeo/cssquery-prototype.html) 06:06:20 INFO - PROCESS | 1907 | RSS: Main: 266108928 06:06:20 INFO - PROCESS | 1907 | 06:09:23 INFO - PROCESS | 1907 | Cycle 1(1): loaded http://localhost:57531/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57531/tests/dromaeo/cssquery-yui.html) 06:09:24 INFO - PROCESS | 1907 | RSS: Main: 276258816 06:09:24 INFO - PROCESS | 1907 | 06:12:26 INFO - PROCESS | 1907 | Cycle 1(1): loaded http://localhost:57531/tests/dromaeo/cssquery-yui.html (next: http://localhost:57531/tests/dromaeo/cssquery-dojo.html) 06:12:27 INFO - PROCESS | 1907 | RSS: Main: 270245888 06:12:27 INFO - PROCESS | 1907 | 06:12:27 INFO - PROCESS | 1907 | __start_tp_report 06:12:27 INFO - PROCESS | 1907 | _x_x_mozilla_page_load 06:12:27 INFO - PROCESS | 1907 | _x_x_mozilla_page_load_details 06:12:27 INFO - PROCESS | 1907 | |i|pagename|runs| 06:12:27 INFO - PROCESS | 1907 | |0;dojo.html;2869.3113652723355;3452.5856897172334;3472.2534655049158;3477.5479187705596;3497.038314463522;4953.801847926083;5792.855178620526;5966.8806623867495;6053.697315134242;6060.090986352038;5862.32583252926;5933.288005439354;5954.851128721784;6008.158857759917;6070.635761854292;5238.659487133334;5410.8917821643545;5447.645903016311;5469.617126801106;5524.558035357162;4568.5203053679215;5340;5490.890182196354;5527.115661494162;5571.164325351189;4804.183288840871;4959.784852711109;5315.867103322448;5453.182022696587;5493.505584497374;5406.189071639246;5410.675359478444;5434.402215756264;5468.207109969072;5486.039943009957;4781.497942716;5057.317262169597;5362.168863826074;5394.973025134888;5449.346078470569;5808.273965754281;5839.211706419622;5840.707964601753;5913.645181289136;6032.607880487754;6282.811515654492;6293.716782744787;6307.117003619497;6312.558120931537;6377.5216858735785;6433.163688720437;6445.742170313182;6449.774257900951;6454.2900280969525;6551.80344589663;6043.637381757021;6100.298465676459;6129.662868542228;6153.138560601519;6156.6613836238985;6317.241930968313;6343.27052388972;6468.482521398277;6558;6671.899921501182;5688.573356998241;6086.8130714511135;6185.505159587222;6248.250209974832;6288;6309.14826498426;6315.810525684236;6341.492680585542;6389.584676995981;6397.936020639827;6317.905231421532;6354.3963323484195;6354.8411289717205;6361.968190159112;6364.326982667291;6357;6359.777407790705;6365.045243213555;6367.872642547123;6383.808485745435;5018.146915024455;5067.46791586878;5074;5104.259882317117;5120.820771272987;4597.4712908015335;4630.097131059479;4632.884177895579;4634.003689206769;4675.018246168343;6164.630122192682;6171.59884607499;6204.038374052029;6219.657918814509;6243.906341404882;6273.9372606273355;6283;6384.744610215632;6428.357164283628;6478.255000674889;6114.602550834182;6115.301188036035;6148.292946311231;6149.538784591174;6159.3224745277985;5729.684867332254;5731.111677689964;5731.283589551306;5739.311282646109;5781.421857814269;6366.872662546816;6608.768693095719;6709.597424154566;6728.495362847708;6730.495212859055;6316.305206427198;6318.652474113968;6336.303006669171;6336.809895703136;6419.903701444576;6380.266269378895;6681.732730690913;6716.496262780213;6734.427573656294;6745.5952642841585;6310.463610593151;6326.588771729823;6349.396807303298;6352.650604216812;6455.677216139268;5080.923786143285;6255.530835187288;6276.058591211172;6305.495560355253;6401;5606.635568688022;5981.930103256484;6247.3440288769025;6266.749330026748;6288.937110629018;6123.557162997564;6150.80059388415;6157.907631385443;6243.8126856194385;6288.088227207121;6127.84680382994;6134.04922237054;6211.472024877755;6232.719527621177;6238.220222472191;6257.906131407942;6277.403646653561;6279.340669229665;6279.686015699105;6294.968525157345;6051.273847138372;6077.331493535619;6167.969160154171;6189.102580125947;6200.0699895016105 06:12:27 INFO - PROCESS | 1907 | |1;ext.html;707.8407358344369;735.9006534117894;798.6485946183681;932.622287973371;938.5682586010431;35965.2806943861;38089.80955095224;39792.40311395331;39817.20365592687;39843;38128.23743525128;38336.233275334474;38347.808260958656;38410;38413.23173536535;7679.424043196755;7842.764717058469;10784.029437350637;11040.3375797452;11173.273737207097;10839.729006774814;10942.726431839188;10942.835857462145;10954.507047182857;10979.945100274488;10910.399928003997;10942.617008404708;10948.945255273713;10951.507182176781;10953.780924381508;10912.017918387344;10919.235653504258;10927.945360273226;10935.781284374347;10991.505382257817;10710.571577136905;10774.784504309948;10779.191560632984;10789.622363217328;10816;38253.42619860704;38384.04039898997;38502.80748596267;38534.42198367027;38580.421293680614;3741.820345032697;3758.229562939591;3767.660910518039;3798.5441746990264;3834.65488106069;27420.17739467819;27752.889884404598;28004.579931300843;28119.718802811916;28729.56905646417;3106.8912588059534;3131.85906634202;3164.3671265746943;3179.1104050834088;3265.8203798791055;338495;340507;343216.9999999975;343700;344733;50426.74786626043;50478.7380315495;50664.49335506671;50753.746231268604;50832.237516437286;51829.076237757356;51948.18181363634;52146.73926630418;52173.478265216865;52340.214896776575;11580.88419115815;14758.40966361355;14806;14817.851821481647;14833.480828171178;12006.939965300118;12024.278543287432;12038.75922481563;12047.03623710101;12064.879351206551;13671.316434178252;13743.931280343535;13813.861861381258;13905.930470347583;13939.442422303197;6020.638761674313;6087;6092.939070609237;6104.11490333908;6177.752889884354;860.6428332242175;905.3300557587338;907.6233363154217;927.9118483744033;936.391345625349;28210.43579128406;28345;28977.59649701563;29059.837606495505;29063.9827606037;1037.83243850668;1040.9843852342221;1069.2408390043001;1070.5343175718588;1110.9777804443866;11844.881551184379;13398.330083495786;14347.497837575635;14643.194624295766;14708;469974;471319;471795;475065;476572;52755.47244527505;52759.94480110376;52896.735516322944;53155.73422132865;53219.935601287754;1184.8815118488255;1384.0519244317875;1415.8725714685727;1419.474794326106;1424.223798030076;28960.855195723885;29105.563416548346;29404.70595294105;29947.401051979276;30066.549001764553;45516.31725524054;45665;45763;45799.542004580864;45872.770636146604;490931;491464;492500;494095;494364;33653.49519757157;34135.65864341325;34441.82779086089;34452.13869653179;34482.31035379228;42434;42535.149297014505;43190.78404608082;43312;43446.565534345515;33646.49530257097;35019.64980350164;35081.298374032885;36136.096597585274;36180.63819361878;34878.476822848184;35258.647413525534;35755.10612234715;35956.92129236127;36075.09812254715;34405.655943440244;34639.96080117601;35385.46921796124;35485.64514354926;35732;28621.856890715415;30559.388812224075;30617;30627.08118756441;30714;22334.553308933406;23179.97025285077;23984.160554380513;23998.331587127235;24106.87946560256 06:12:27 INFO - PROCESS | 1907 | |2;jquery.html;327.8065941094754;399.5804405374358;406.57919053779335;418.95600961899;436.8230866499067;18924.810751892477;20514.794852051476;21742.804145771977;21841.563168736637;21980.560388792215;21449.785502144972;21488.247911323106;21646.783532164674;21975.450613734665;22136.557268854613;6490.545661803664;6662.500312476559;6714.932850671479;6738.898916516232;6744.865102697943;6313.368663133673;6773.254941956381;7159.4988350815465;7468;7631.961840190791;7316.122065352165;7610.277023682769;7635.770926872175;7642.312191902728;7673.2326767323375;7528.849423011537;7602.049743782028;7609.885851712229;7629.961850190713;7631.54210747357;7093.8226544336285;7285.380742636882;7362.37419819316;7363.558186508827;7376.9262307376775;25352.746472535222;27162.913483460834;27339.726602733917;27343.316417089532;27369.45261094767;2637.907673231447;2701.770349520293;2738.219607411878;2741.6024676422007;3326.2017115892254;15409.383624655;15843.366265349372;15862.920685396499;16375.918120409322;17066.061366624832;2026.9695954560693;2046.741254128715;2052.158614967856;2060.9072591733407;2097.1611355457785;133405;140771;162982.18508907498;163813;164206;22709.318720438412;23232.883835580713;23451.648225276633;23617.40956476102;23781.167659131846;35759.82120089383;35778.821105894305;35813;35923.74266900646;35930;10602.57589696419;10684.305520141166;10870.782584348426;10923.453827308604;11218.270812397168;8800;8816.691415800417;8822.779430514289;8988.10118988096;8995.32535059873;9761.902380976242;10724.839127413095;10743.409112498732;10842.674719758419;10856.674299771019;4019.457373254632;4169.144730594917;4246.129543443587;4258.488981322199;4285;815.8368326334638;961.9855702164473;1030.05749738988;1065.984010239847;1101.7906597746403;22450.88774556117;22530;22579.774202258097;22628.208012719475;22653.660195097087;1028.18773169197;1034.9741256468499;1041.520900385831;1048.6539441984128;1083.6586475260267;10915.727106822393;10990.725231869108;11801.940990294994;11837.704057398634;11859.822102668468;689328;696947;698717;712095;717981;141776.29111854374;150935;154583;157549.212253938;160565;1031.1018514499667;1225.381182502848;1256.698392385839;1258.4903114238748;1260.5147018397984;19633.31283405074;19704.605907882047;20007.299744508873;20008.799472031726;20088.59822803565;46848;61322;61573.69213153906;62140.37859621346;62578;86117;86696.4977626668;88187.67718484356;88319;89833.55083224803;7580.583067931096;10347;10996.515470411392;11817.468213930222;12456.31490268044;13423.932880335537;13455.663608409868;13838.308084595932;13857.168569885838;13989.790153147507;10318.329308594917;11448.599299024494;11457;11797.646070617895;12030.27818330903;10601.41692206936;10764.838527422251;10867;11260.9436952818;11760;10872.184586155912;11625.302481850778;12061.216020958609;12088.972437342924;12184.329861857683;11927.403629818647;11973.820392693942;12223.266604003788;12239.265644061385;12302.569410070604;11511.942440287745;11529.82705259405;11817.172797904064;11874.821877672015;11956.402179890796 06:12:27 INFO - PROCESS | 1907 | |3;mootools.html;1531.21142611555;1549.1944189021715;1555.4478160253109;1572.096044774255;1572.3081843988643;10468.476576171199;10933.945330273338;11041.613543525978;11102.666919992393;11107.222494425394;11174.66476005721;11343.149263805206;11349.773004539904;11379.146564007691;11407.973282404582;1962.2249211561425;2336.96494552581;2337.91817286395;2338.1816364272454;2343.3087239264373;2216.8115710164657;2251.797338239558;2254.4814692620707;2257.413072601119;2264.8980795864227;2287.3481057898503;2293.81649468043;2300.2869110575693;2310.676505289261;2312.109837712476;2266.841321107523;2275.260540324393;2282.167009041704;2288.668143119247;2308.4344335637793;1883.4726276642562;2321.6981792366882;2324.070371851273;2325.9767402326097;2331.6852224949753;10983;11040.944795276053;11043.171762117874;11051.889481105167;11083.667489975232;5584.5253153482;5744.109663002199;5754.194412782172;5759.510441612468;5760.53915686744;3308.536804847299;3419.333230020147;3611.801350925698;3615;3630.7458477906293;1150.1718762490993;1165.4289398194824;1175.7354595216093;1199.622119032502;1221.0841868598552;15150.621234469116;15310.157941313224;15412.30644621006;15492.30284637194;15501;4346.630536404377;4584.747838868828;4605.907881842411;4666.253399456071;4707.646926480459;11453.541858325574;11513.194076414738;11533.077353811675;11553.364564949008;11558.711032224262;5564.610477266552;5597.272354593958;5609.0184217761725;5615.9157612635845;5618.213450116987;4997.425296090923;5111.412187598399;5124.743762811844;5138.640295179302;5217.269582258411;3765.4728338032696;3793.639604237593;3805.657490825839;3889.0666240102737;3892.338302488584;870.1776820904184;1019.6635110413546;1024.5696807340935;1040.3653771199563;1041.1670663469195;895.2166854002747;920.231606608476;925.1581061234244;939.736873675372;987.0672214756986;6316.841777069513;6351.174347334817;6533.314002029719;6622.4039836413995;6648.900266496006;787.7715462515806;822.321584692631;935.9672411465566;938.4697645830084;981.5239608789731;3783.243351329745;4061.89845253871;4094.303968325392;4207.474065741782;4208.831646734157;12963.805542916863;13473.86526134726;13698.863011369758;13706.794398084037;13741.793873091912;12810.359482025862;13613.183209007491;13630.591082267549;13650.249236292098;13677;7575.393968482618;9112.22546083577;9123.726288211365;9160.496172710431;9214.078592140866;6659.966700166468;6715.7985260442265;6753.189617245962;6884.139482564679;6916.20463646687;11578.363190024293;11977.401129943293;12190.634280971584;12205.633830985085;12212.130149414703;10202.183825294107;11777.52889884395;12237.265764054186;12243.57147499869;12263.202891812003;8368.874466883124;9242.260619150586;9265.119813617695;9428.057194280516;9451.669191578261;9066.138716821892;10037.297389182688;10464.63373781914;10552.947235263775;10622.415767132881;8102.432829701865;9053.094690530894;9069.909300906906;9439.716808495756;9802.019798020141;8875.378723489552;9380;9521.238300936047;9524.619015239312;9560.952195238979;7799.18108598589;7883.7240696575345;7957.880631790412;7966.3626909848235;7973.481723687942;5679.977604031314;5869.383714709894;5993.790217342372;6055.061465472859;6120.357362477054;5914.763409463573;5969.552283578662;6016.669083200466;6025.66858822769;6126.977522858522 06:12:27 INFO - PROCESS | 1907 | |4;prototype.html;370.823858667133;380.38187944590044;384.68840239406086;389.33423845224655;391.05365016659664;5202.820108250618;5257.500537448946;5295.31160949077;5324.8019195681;5364.865878353043;4490.910181796362;4883.340748998884;4915.483874193203;5237.319148510698;5245.423003469616;3968.968068302248;3969.8610548630804;4186.958130418688;4301.8064187111495;4328.891777705551;3950.6641935435523;4377.846775362863;4393.846215382462;4409.9934529789025;4444.866654000385;3837.961620383788;3909.569947305794;4355.912881742363;4365.140832754535;4397.978010109961;3491.8302368706513;3576.998440436656;3755.830987605564;4408.493023302329;4428.557144285562;3442.9326908658395;3816.3589656447716;3915.4322623219473;3939.7439166454374;3991.381335892941;4392.231359512072;4468.82124715011;4585.518520555361;4625.838095666635;5070.797168113271;4232.8518501852595;4245.724027938205;4567.840125595621;5010.549050585429;5088.872778180538;4958.380202474691;4980.452150263504;5167.354080739908;5167.612429067835;5568.693721845297;3769.905752356213;4158.981049642826;4247.600105940134;4450.863585478955;4494.9775251123865;5134.358205224347;5329.907368989348;5603.551715862721;5978.491828194608;6001.789937352215;3687.778733276012;3773.547184334051;4057.431959525669;4152.024274295538;4610.700304480198;4138.8551400700835;4641.327007583882;4648;4666.743329116864;4668.6965347253;4246.8533495956535;4986.376702912136;5000.224965130411;5021.322121513622;5032.018756342552;5410.702411367412;5542.445755424425;5565.860853478695;5579.6652200868075;5594.524465420485;1458.4166333466485;1472.4404726203975;1481.4370539195038;1485.3093311610153;1554.8678362339328;1084.7505073833063;1124.533318672758;1127.763169734365;1161.5353858456515;1188.9834191766088;4591.701539399928;5034.521720436553;5161.122609156378;5169.896602067937;5184.974075129676;5034.723090229999;5266.657667251617;5804.535637149018;5807.303123625107;5810.477057064884;4237.8304867804945;4791;4891.510848915151;4897.951020489821;5141.691498510027;2582.5093232285803;2821.3228825081833;2964.688707685705;2979.6722360540325;2987.191331052925;5242;5641.379448260688;5905.704714764244;5943.31651860033;5975.43233392827;4939.925901111486;5365.195220716846;5390.757415916215;5402;5581.832545023656;5274.7626356814035;5471.2887324647545;5618.831435056954;5816.214811000461;6052.848678783065;5054.848354549369;5086.33877595925;5757.740901659519;5823.301203855564;5843.208568973401;4916.680415772963;5273.574155888335;5543.334799824047;5743.8564035899435;5793.391693872083;4880.804767809248;5427.48438898304;5735.971320143372;5890.846952898282;6124.969375153096;4416.006398560298;4580.602916110618;4617.930731039104;4641.767911604339;4657.953420465752;4722.693024953367;5391.514763671288;5520.944790552043;5640.88718225625;5832.687645279948;5353.848922481685;5436.429174936575;5631.267935168402;5693.149726338874;5732.684702341245;4825.662203645711;4862.82980095695;5223;5603.467670571289;5674.404187560247;4861.878453038702;5405.378381486179;5433.347998240237;5486.561075114061;5489.451054894478;5059.494050594911;5178;5236.816711415235;5503.734141147478;5622.449845929446;4907.288443175791;5145.228215767665;5506.091494903296;5506.475855452593;5552.114758356155 06:12:27 INFO - PROCESS | 1907 | |5;yui.html;595.5354823237876;728.078980090186;728.8797348437507;766.4136935244535;857.2070834478108;15019.474318398858;16011.719062474975;16029.519114426557;16149.192540372978;16185.35258589655;14600.926995365035;15123;15151.469698560553;15275.847241527581;15277.69444611107;906.9773255668595;944.6740874398356;944.7449188719041;949.5204921514626;950.9001554836747;931.161954241185;939.3893968920188;939.492673956063;939.5959737312953;955.0878910640322;1020.5968642386252;1027.9177665786756;1029.6756521695643;1031.0926384781383;1032.6282538286248;1015.8069966706377;1020.4285600063951;1026.1021606094666;1026.630413051301;1027.1372047480115;748.9325960663512;755.1919446192576;760.232165512836;761.090496856257;763.6258233465618;15930.840691593052;16391.672166556604;16413.261403236884;16835.989840609604;17168;14101.506447274296;14233.50182743599;14245.430182792676;14282.85717142836;14348.784768228485;9918.80162396748;11522.827157592643;11764.235324703952;11786.410679465993;12266.018718502499;3679.632036796326;3688.0964163779777;3719.2933342664805;3722.758020728644;3808.4668146459517;94661.05338946592;114403;116183.41908290405;116243.67512649784;117878.82121178764;9581.856272155923;11214.383208923588;11235.101191904629;11727;11766.529338826522;24805;25003.37491562689;25116.24651260465;25141.622875656878;25250.989960401377;6820.727170913207;7806.6096695165015;7870.72452464161;7913.089994650689;8015.879761803578;4224.685043099393;4232.246254253141;4238.957610423918;4248.235317642792;4313.137999512263;3499.4051011328133;3542.3800834854314;3574.21367299199;3577;3590.551181102362;630.574362305442;634.6858305138893;637.4549759955172;650.8437974886087;651.1892693596408;582.939567271823;640.7789312687115;676.9763058292937;690.7450107338769;703.63762662229;9095.590183521565;10051.949740251399;10241.692749217535;10260.025297596716;10459.895401045893;659.7328082126746;673;677.4140368581241;684.4011489946297;703.9472039597051;4633.374494443275;4926.778294976734;4930.186519224288;4943.90112197754;4967.180415231519;104319;105035.4748226254;106051.87896242186;107153.4642326799;108272.45863770631;91051;91673;92392.61411078839;93987;94238;77611.61194193993;78568.60715696384;79100;79478.60260698776;80746.59626701829;9347.896723237218;9527.142557169887;9543.997880222754;9613.213297229267;9717.416954982724;52155;52340.73829630828;52552.47447525629;53592.73203634113;54423;53933.46066539284;69153.65423173053;69709;70180.29819701737;70471.29528704648;11652.592159274385;11748.876697365999;11778;11837.82243266369;12420.378981051092;12739.171953822972;12844.935775321064;12948;12987.155834870704;13125.868741312846;10663;11145.2198346115;11890.16768826174;11924.105692072955;12145.57490487864;10361.896381036093;11820.70448238801;11873;12263.38683065861;12680.6829829255;10128.44293563861;11539.711507212387;11628.592999244986;11670.649880503599;11870;10179.515308666778;10215.438150901475;10241.18070554339;10491.895081049091;10583.512874474338;8660.220580147565;9005.459672419676;9992.600295988079;10009.199264058712;10044.045815647502 06:12:27 INFO - PROCESS | 1907 | __end_tp_report 06:12:27 INFO - PROCESS | 1907 | __start_cc_report 06:12:27 INFO - PROCESS | 1907 | _x_x_mozilla_cycle_collect,430 06:12:27 INFO - PROCESS | 1907 | __end_cc_report 06:12:27 INFO - PROCESS | 1907 | __startTimestamp1489068747172__endTimestamp 06:12:27 INFO - PROCESS | 1907 | 06:12:27 INFO - PROCESS | 1907 | ------- Summary: start ------- 06:12:27 INFO - PROCESS | 1907 | Number of tests: 6 06:12:27 INFO - PROCESS | 1907 | 06:12:27 INFO - PROCESS | 1907 | [#0] dojo.html Cycles:165 Average:5914.19 Median:6164.63 stddev:684.72 (11.1%) stddev-sans-first:643.81 06:12:27 INFO - PROCESS | 1907 | Values: 2869.3 3452.6 3472.3 3477.5 3497.0 4953.8 5792.9 5966.9 6053.7 6060.1 5862.3 5933.3 5954.9 6008.2 6070.6 5238.7 5410.9 5447.6 5469.6 5524.6 4568.5 5340.0 5490.9 5527.1 5571.2 4804.2 4959.8 5315.9 5453.2 5493.5 5406.2 5410.7 5434.4 5468.2 5486.0 4781.5 5057.3 5362.2 5395.0 5449.3 5808.3 5839.2 5840.7 5913.6 6032.6 6282.8 6293.7 6307.1 6312.6 6377.5 6433.2 6445.7 6449.8 6454.3 6551.8 6043.6 6100.3 6129.7 6153.1 6156.7 6317.2 6343.3 6468.5 6558.0 6671.9 5688.6 6086.8 6185.5 6248.3 6288.0 6309.1 6315.8 6341.5 6389.6 6397.9 6317.9 6354.4 6354.8 6362.0 6364.3 6357.0 6359.8 6365.0 6367.9 6383.8 5018.1 5067.5 5074.0 5104.3 5120.8 4597.5 4630.1 4632.9 4634.0 4675.0 6164.6 6171.6 6204.0 6219.7 6243.9 6273.9 6283.0 6384.7 6428.4 6478.3 6114.6 6115.3 6148.3 6149.5 6159.3 5729.7 5731.1 5731.3 5739.3 5781.4 6366.9 6608.8 6709.6 6728.5 6730.5 6316.3 6318.7 6336.3 6336.8 6419.9 6380.3 6681.7 6716.5 6734.4 6745.6 6310.5 6326.6 6349.4 6352.7 6455.7 5080.9 6255.5 6276.1 6305.5 6401.0 5606.6 5981.9 6247.3 6266.7 6288.9 6123.6 6150.8 6157.9 6243.8 6288.1 6127.8 6134.0 6211.5 6232.7 6238.2 6257.9 6277.4 6279.3 6279.7 6295.0 6051.3 6077.3 6168.0 6189.1 6200.1 06:12:27 INFO - PROCESS | 1907 | 06:12:27 INFO - PROCESS | 1907 | [#1] ext.html Cycles:180 Average:57556.89 Median:34423.74 stddev:117099.90 (340.2%) stddev-sans-first:117350.61 06:12:27 INFO - PROCESS | 1907 | Values: 707.8 735.9 798.6 932.6 938.6 35965.3 38089.8 39792.4 39817.2 39843.0 38128.2 38336.2 38347.8 38410.0 38413.2 7679.4 7842.8 10784.0 11040.3 11173.3 10839.7 10942.7 10942.8 10954.5 10979.9 10910.4 10942.6 10948.9 10951.5 10953.8 10912.0 10919.2 10927.9 10935.8 10991.5 10710.6 10774.8 10779.2 10789.6 10816.0 38253.4 38384.0 38502.8 38534.4 38580.4 3741.8 3758.2 3767.7 3798.5 3834.7 27420.2 27752.9 28004.6 28119.7 28729.6 3106.9 3131.9 3164.4 3179.1 3265.8 338495.0 340507.0 343217.0 343700.0 344733.0 50426.7 50478.7 50664.5 50753.7 50832.2 51829.1 51948.2 52146.7 52173.5 52340.2 11580.9 14758.4 14806.0 14817.9 14833.5 12006.9 12024.3 12038.8 12047.0 12064.9 13671.3 13743.9 13813.9 13905.9 13939.4 6020.6 6087.0 6092.9 6104.1 6177.8 860.6 905.3 907.6 927.9 936.4 28210.4 28345.0 28977.6 29059.8 29064.0 1037.8 1041.0 1069.2 1070.5 1111.0 11844.9 13398.3 14347.5 14643.2 14708.0 469974.0 471319.0 471795.0 475065.0 476572.0 52755.5 52759.9 52896.7 53155.7 53219.9 1184.9 1384.1 1415.9 1419.5 1424.2 28960.9 29105.6 29404.7 29947.4 30066.5 45516.3 45665.0 45763.0 45799.5 45872.8 490931.0 491464.0 492500.0 494095.0 494364.0 33653.5 34135.7 34441.8 34452.1 34482.3 42434.0 42535.1 43190.8 43312.0 43446.6 33646.5 35019.6 35081.3 36136.1 36180.6 34878.5 35258.6 35755.1 35956.9 36075.1 34405.7 34640.0 35385.5 35485.6 35732.0 28621.9 30559.4 30617.0 30627.1 30714.0 22334.6 23180.0 23984.2 23998.3 24106.9 06:12:27 INFO - PROCESS | 1907 | 06:12:27 INFO - PROCESS | 1907 | [#2] jquery.html Cycles:180 Average:42124.43 Median:21694.79 stddev:117599.69 (542.1%) stddev-sans-first:117887.71 06:12:27 INFO - PROCESS | 1907 | Values: 327.8 399.6 406.6 419.0 436.8 18924.8 20514.8 21742.8 21841.6 21980.6 21449.8 21488.2 21646.8 21975.5 22136.6 6490.5 6662.5 6714.9 6738.9 6744.9 6313.4 6773.3 7159.5 7468.0 7632.0 7316.1 7610.3 7635.8 7642.3 7673.2 7528.8 7602.0 7609.9 7630.0 7631.5 7093.8 7285.4 7362.4 7363.6 7376.9 25352.7 27162.9 27339.7 27343.3 27369.5 2637.9 2701.8 2738.2 2741.6 3326.2 15409.4 15843.4 15862.9 16375.9 17066.1 2027.0 2046.7 2052.2 2060.9 2097.2 133405.0 140771.0 162982.2 163813.0 164206.0 22709.3 23232.9 23451.6 23617.4 23781.2 35759.8 35778.8 35813.0 35923.7 35930.0 10602.6 10684.3 10870.8 10923.5 11218.3 8800.0 8816.7 8822.8 8988.1 8995.3 9761.9 10724.8 10743.4 10842.7 10856.7 4019.5 4169.1 4246.1 4258.5 4285.0 815.8 962.0 1030.1 1066.0 1101.8 22450.9 22530.0 22579.8 22628.2 22653.7 1028.2 1035.0 1041.5 1048.7 1083.7 10915.7 10990.7 11801.9 11837.7 11859.8 689328.0 696947.0 698717.0 712095.0 717981.0 141776.3 150935.0 154583.0 157549.2 160565.0 1031.1 1225.4 1256.7 1258.5 1260.5 19633.3 19704.6 20007.3 20008.8 20088.6 46848.0 61322.0 61573.7 62140.4 62578.0 86117.0 86696.5 88187.7 88319.0 89833.6 7580.6 10347.0 10996.5 11817.5 12456.3 13423.9 13455.7 13838.3 13857.2 13989.8 10318.3 11448.6 11457.0 11797.6 12030.3 10601.4 10764.8 10867.0 11260.9 11760.0 10872.2 11625.3 12061.2 12089.0 12184.3 11927.4 11973.8 12223.3 12239.3 12302.6 11511.9 11529.8 11817.2 11874.8 11956.4 06:12:27 INFO - PROCESS | 1907 | 06:12:27 INFO - PROCESS | 1907 | [#3] mootools.html Cycles:180 Average:6668.38 Median:3613.40 stddev:4202.76 (116.3%) stddev-sans-first:4196.82 06:12:27 INFO - PROCESS | 1907 | Values: 1531.2 1549.2 1555.4 1572.1 1572.3 10468.5 10933.9 11041.6 11102.7 11107.2 11174.7 11343.1 11349.8 11379.1 11408.0 1962.2 2337.0 2337.9 2338.2 2343.3 2216.8 2251.8 2254.5 2257.4 2264.9 2287.3 2293.8 2300.3 2310.7 2312.1 2266.8 2275.3 2282.2 2288.7 2308.4 1883.5 2321.7 2324.1 2326.0 2331.7 10983.0 11040.9 11043.2 11051.9 11083.7 5584.5 5744.1 5754.2 5759.5 5760.5 3308.5 3419.3 3611.8 3615.0 3630.7 1150.2 1165.4 1175.7 1199.6 1221.1 15150.6 15310.2 15412.3 15492.3 15501.0 4346.6 4584.7 4605.9 4666.3 4707.6 11453.5 11513.2 11533.1 11553.4 11558.7 5564.6 5597.3 5609.0 5615.9 5618.2 4997.4 5111.4 5124.7 5138.6 5217.3 3765.5 3793.6 3805.7 3889.1 3892.3 870.2 1019.7 1024.6 1040.4 1041.2 895.2 920.2 925.2 939.7 987.1 6316.8 6351.2 6533.3 6622.4 6648.9 787.8 822.3 936.0 938.5 981.5 3783.2 4061.9 4094.3 4207.5 4208.8 12963.8 13473.9 13698.9 13706.8 13741.8 12810.4 13613.2 13630.6 13650.2 13677.0 7575.4 9112.2 9123.7 9160.5 9214.1 6660.0 6715.8 6753.2 6884.1 6916.2 11578.4 11977.4 12190.6 12205.6 12212.1 10202.2 11777.5 12237.3 12243.6 12263.2 8368.9 9242.3 9265.1 9428.1 9451.7 9066.1 10037.3 10464.6 10552.9 10622.4 8102.4 9053.1 9069.9 9439.7 9802.0 8875.4 9380.0 9521.2 9524.6 9561.0 7799.2 7883.7 7957.9 7966.4 7973.5 5680.0 5869.4 5993.8 6055.1 6120.4 5914.8 5969.6 6016.7 6025.7 6127.0 06:12:27 INFO - PROCESS | 1907 | 06:12:27 INFO - PROCESS | 1907 | [#4] prototype.html Cycles:180 Average:4590.01 Median:4983.41 stddev:1294.19 (26.0%) stddev-sans-first:1258.48 06:12:27 INFO - PROCESS | 1907 | Values: 370.8 380.4 384.7 389.3 391.1 5202.8 5257.5 5295.3 5324.8 5364.9 4490.9 4883.3 4915.5 5237.3 5245.4 3969.0 3969.9 4187.0 4301.8 4328.9 3950.7 4377.8 4393.8 4410.0 4444.9 3838.0 3909.6 4355.9 4365.1 4398.0 3491.8 3577.0 3755.8 4408.5 4428.6 3442.9 3816.4 3915.4 3939.7 3991.4 4392.2 4468.8 4585.5 4625.8 5070.8 4232.9 4245.7 4567.8 5010.5 5088.9 4958.4 4980.5 5167.4 5167.6 5568.7 3769.9 4159.0 4247.6 4450.9 4495.0 5134.4 5329.9 5603.6 5978.5 6001.8 3687.8 3773.5 4057.4 4152.0 4610.7 4138.9 4641.3 4648.0 4666.7 4668.7 4246.9 4986.4 5000.2 5021.3 5032.0 5410.7 5542.4 5565.9 5579.7 5594.5 1458.4 1472.4 1481.4 1485.3 1554.9 1084.8 1124.5 1127.8 1161.5 1189.0 4591.7 5034.5 5161.1 5169.9 5185.0 5034.7 5266.7 5804.5 5807.3 5810.5 4237.8 4791.0 4891.5 4898.0 5141.7 2582.5 2821.3 2964.7 2979.7 2987.2 5242.0 5641.4 5905.7 5943.3 5975.4 4939.9 5365.2 5390.8 5402.0 5581.8 5274.8 5471.3 5618.8 5816.2 6052.8 5054.8 5086.3 5757.7 5823.3 5843.2 4916.7 5273.6 5543.3 5743.9 5793.4 4880.8 5427.5 5736.0 5890.8 6125.0 4416.0 4580.6 4617.9 4641.8 4658.0 4722.7 5391.5 5520.9 5640.9 5832.7 5353.8 5436.4 5631.3 5693.1 5732.7 4825.7 4862.8 5223.0 5603.5 5674.4 4861.9 5405.4 5433.3 5486.6 5489.5 5059.5 5178.0 5236.8 5503.7 5622.4 4907.3 5145.2 5506.1 5506.5 5552.1 06:12:27 INFO - PROCESS | 1907 | 06:12:27 INFO - PROCESS | 1907 | [#5] yui.html Cycles:180 Average:20816.21 Median:3575.61 stddev:30584.84 (855.4%) stddev-sans-first:30632.95 06:12:27 INFO - PROCESS | 1907 | Values: 595.5 728.1 728.9 766.4 857.2 15019.5 16011.7 16029.5 16149.2 16185.4 14600.9 15123.0 15151.5 15275.8 15277.7 907.0 944.7 944.7 949.5 950.9 931.2 939.4 939.5 939.6 955.1 1020.6 1027.9 1029.7 1031.1 1032.6 1015.8 1020.4 1026.1 1026.6 1027.1 748.9 755.2 760.2 761.1 763.6 15930.8 16391.7 16413.3 16836.0 17168.0 14101.5 14233.5 14245.4 14282.9 14348.8 9918.8 11522.8 11764.2 11786.4 12266.0 3679.6 3688.1 3719.3 3722.8 3808.5 94661.1 114403.0 116183.4 116243.7 117878.8 9581.9 11214.4 11235.1 11727.0 11766.5 24805.0 25003.4 25116.2 25141.6 25251.0 6820.7 7806.6 7870.7 7913.1 8015.9 4224.7 4232.2 4239.0 4248.2 4313.1 3499.4 3542.4 3574.2 3577.0 3590.6 630.6 634.7 637.5 650.8 651.2 582.9 640.8 677.0 690.7 703.6 9095.6 10051.9 10241.7 10260.0 10459.9 659.7 673.0 677.4 684.4 703.9 4633.4 4926.8 4930.2 4943.9 4967.2 104319.0 105035.5 106051.9 107153.5 108272.5 91051.0 91673.0 92392.6 93987.0 94238.0 77611.6 78568.6 79100.0 79478.6 80746.6 9347.9 9527.1 9544.0 9613.2 9717.4 52155.0 52340.7 52552.5 53592.7 54423.0 53933.5 69153.7 69709.0 70180.3 70471.3 11652.6 11748.9 11778.0 11837.8 12420.4 12739.2 12844.9 12948.0 12987.2 13125.9 10663.0 11145.2 11890.2 11924.1 12145.6 10361.9 11820.7 11873.0 12263.4 12680.7 10128.4 11539.7 11628.6 11670.6 11870.0 10179.5 10215.4 10241.2 10491.9 10583.5 8660.2 9005.5 9992.6 10009.2 10044.0 06:12:27 INFO - PROCESS | 1907 | -------- Summary: end -------- 06:12:27 INFO - PROCESS | 1907 | 06:12:27 INFO - TEST-INFO | 1907: exit 0 06:12:27 INFO - TEST-OK | dromaeo_css | took 1116918ms 06:12:27 INFO - TEST-START | kraken 06:12:27 INFO - operating with platform_type : mac_ 06:12:27 INFO - Initialising browser for kraken test... 06:12:27 INFO - TEST-INFO | started process 1913 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/tmpJmUX6b/profile http://localhost:57531/getInfo.html) 06:12:30 INFO - PROCESS | 1913 | 2017-03-09 06:12:30.748 plugin-container[1915:23628] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x893f, name = 'com.apple.tsm.portname' 06:12:30 INFO - PROCESS | 1913 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:12:30 INFO - PROCESS | 1913 | 2017-03-09 06:12:30.749 plugin-container[1915:23628] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 06:12:30 INFO - PROCESS | 1913 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:12:30 INFO - PROCESS | 1913 | 2017-03-09 06:12:30.749 plugin-container[1915:23628] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 06:12:30 INFO - PROCESS | 1913 | __metrics Screen width/height:1600/1200 06:12:30 INFO - PROCESS | 1913 | colorDepth:24 06:12:30 INFO - PROCESS | 1913 | Browser inner width/height: 1024/689 06:12:30 INFO - PROCESS | 1913 | __metrics 06:12:30 ERROR - PROCESS | 1913 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3353: TypeError: this.tabs is undefined 06:12:31 INFO - TEST-INFO | 1913: exit 0 06:12:31 INFO - Browser initialized. 06:12:31 INFO - Running cycle 1/1 for kraken test... 06:12:31 INFO - TEST-INFO | started process 1916 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/T/tmpJmUX6b/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:12:34 INFO - PROCESS | 1916 | 2017-03-09 06:12:34.257 plugin-container[1917:23757] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c4b, name = 'com.apple.tsm.portname' 06:12:34 INFO - PROCESS | 1916 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:12:34 INFO - PROCESS | 1916 | 2017-03-09 06:12:34.258 plugin-container[1917:23757] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4413, name = 'com.apple.CFPasteboardClient' 06:12:34 INFO - PROCESS | 1916 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:12:34 INFO - PROCESS | 1916 | 2017-03-09 06:12:34.258 plugin-container[1917:23757] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 06:12:44 INFO - PROCESS | 1916 | RSS: Main: 228282368 06:12:44 INFO - PROCESS | 1916 | 06:12:46 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:57531/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57531/tests/kraken/driver.html?testName=audio-beat-detection) 06:12:47 INFO - PROCESS | 1916 | RSS: Main: 241381376 06:12:47 INFO - PROCESS | 1916 | 06:12:50 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:57531/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57531/tests/kraken/driver.html?testName=audio-dft) 06:12:51 INFO - PROCESS | 1916 | RSS: Main: 250466304 06:12:51 INFO - PROCESS | 1916 | 06:12:54 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:57531/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57531/tests/kraken/driver.html?testName=audio-fft) 06:12:55 INFO - PROCESS | 1916 | RSS: Main: 252555264 06:12:55 INFO - PROCESS | 1916 | 06:12:57 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:57531/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57531/tests/kraken/driver.html?testName=audio-oscillator) 06:12:57 INFO - PROCESS | 1916 | RSS: Main: 254836736 06:12:57 INFO - PROCESS | 1916 | 06:12:59 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:57531/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57531/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:13:00 INFO - PROCESS | 1916 | RSS: Main: 255164416 06:13:00 INFO - PROCESS | 1916 | 06:13:03 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:57531/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57531/tests/kraken/driver.html?testName=imaging-darkroom) 06:13:04 INFO - PROCESS | 1916 | RSS: Main: 260997120 06:13:04 INFO - PROCESS | 1916 | 06:13:07 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:57531/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57531/tests/kraken/driver.html?testName=imaging-desaturate) 06:13:08 INFO - PROCESS | 1916 | RSS: Main: 262209536 06:13:08 INFO - PROCESS | 1916 | 06:13:11 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:57531/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57531/tests/kraken/driver.html?testName=json-parse-financial) 06:13:12 INFO - PROCESS | 1916 | RSS: Main: 261885952 06:13:12 INFO - PROCESS | 1916 | 06:13:13 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:57531/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57531/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:13:14 INFO - PROCESS | 1916 | RSS: Main: 261754880 06:13:14 INFO - PROCESS | 1916 | 06:13:16 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:57531/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57531/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:13:16 INFO - PROCESS | 1916 | RSS: Main: 261742592 06:13:16 INFO - PROCESS | 1916 | 06:13:19 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:57531/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57531/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:13:19 INFO - PROCESS | 1916 | RSS: Main: 261832704 06:13:19 INFO - PROCESS | 1916 | 06:13:22 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:57531/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57531/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:13:23 INFO - PROCESS | 1916 | RSS: Main: 262402048 06:13:23 INFO - PROCESS | 1916 | 06:13:26 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:57531/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57531/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:13:27 INFO - PROCESS | 1916 | RSS: Main: 259395584 06:13:27 INFO - PROCESS | 1916 | 06:13:29 INFO - PROCESS | 1916 | Cycle 1(1): loaded http://localhost:57531/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57531/tests/kraken/driver.html?testName=ai-astar) 06:13:29 INFO - PROCESS | 1916 | RSS: Main: 262823936 06:13:29 INFO - PROCESS | 1916 | 06:13:29 INFO - PROCESS | 1916 | __start_tp_report 06:13:29 INFO - PROCESS | 1916 | _x_x_mozilla_page_load 06:13:29 INFO - PROCESS | 1916 | _x_x_mozilla_page_load_details 06:13:29 INFO - PROCESS | 1916 | |i|pagename|runs| 06:13:29 INFO - PROCESS | 1916 | |0;ai-astar;121;178;119;120;119;119;119;119;118;119 06:13:29 INFO - PROCESS | 1916 | |1;audio-beat-detection;161;140;111;157;115;114;114;116;138;116 06:13:29 INFO - PROCESS | 1916 | |2;audio-dft;198;214;211;244;228;202;198;246;288;197 06:13:29 INFO - PROCESS | 1916 | |3;audio-fft;82;59;62;87;69;57;63;62;74;64 06:13:29 INFO - PROCESS | 1916 | |4;audio-oscillator;92;72;87;71;70;71;84;103;104;115 06:13:29 INFO - PROCESS | 1916 | |5;imaging-gaussian-blur;110;124;88;105;104;88;89;88;95;87 06:13:29 INFO - PROCESS | 1916 | |6;imaging-darkroom;95;97;97;126;98;158;129;97;97;96 06:13:29 INFO - PROCESS | 1916 | |7;imaging-desaturate;91;106;88;93;89;91;95;91;115;150 06:13:29 INFO - PROCESS | 1916 | |8;json-parse-financial;68;69;68;68;68;69;68;69;68;69 06:13:29 INFO - PROCESS | 1916 | |9;json-stringify-tinderbox;61;62;56;59;62;59;58;57;56;59 06:13:29 INFO - PROCESS | 1916 | |10;stanford-crypto-aes;84;85;90;88;87;86;89;95;97;90 06:13:29 INFO - PROCESS | 1916 | |11;stanford-crypto-ccm;148;159;160;151;144;146;172;155;167;157 06:13:29 INFO - PROCESS | 1916 | |12;stanford-crypto-pbkdf2;163;227;207;178;231;177;176;233;178;227 06:13:29 INFO - PROCESS | 1916 | |13;stanford-crypto-sha256-iterative;71;66;68;67;67;73;79;83;94;92 06:13:29 INFO - PROCESS | 1916 | __end_tp_report 06:13:29 INFO - PROCESS | 1916 | __start_cc_report 06:13:29 INFO - PROCESS | 1916 | _x_x_mozilla_cycle_collect,998 06:13:29 INFO - PROCESS | 1916 | __end_cc_report 06:13:29 INFO - PROCESS | 1916 | __startTimestamp1489068809588__endTimestamp 06:13:29 INFO - PROCESS | 1916 | 06:13:29 INFO - PROCESS | 1916 | ------- Summary: start ------- 06:13:29 INFO - PROCESS | 1916 | Number of tests: 14 06:13:29 INFO - PROCESS | 1916 | 06:13:29 INFO - PROCESS | 1916 | [#0] ai-astar Cycles:10 Average:125.10 Median:119.00 stddev:18.60 (15.6%) stddev-sans-first:19.67 06:13:29 INFO - PROCESS | 1916 | Values: 121.0 178.0 119.0 120.0 119.0 119.0 119.0 119.0 118.0 119.0 06:13:29 INFO - PROCESS | 1916 | 06:13:29 INFO - PROCESS | 1916 | [#1] audio-beat-detection Cycles:10 Average:128.20 Median:127.00 stddev:19.18 (15.1%) stddev-sans-first:16.26 06:13:29 INFO - PROCESS | 1916 | Values: 161.0 140.0 111.0 157.0 115.0 114.0 114.0 116.0 138.0 116.0 06:13:29 INFO - PROCESS | 1916 | 06:13:29 INFO - PROCESS | 1916 | [#2] audio-dft Cycles:10 Average:222.60 Median:221.00 stddev:29.46 (13.3%) stddev-sans-first:29.87 06:13:29 INFO - PROCESS | 1916 | Values: 198.0 214.0 211.0 244.0 228.0 202.0 198.0 246.0 288.0 197.0 06:13:29 INFO - PROCESS | 1916 | 06:13:29 INFO - PROCESS | 1916 | [#3] audio-fft Cycles:10 Average:67.90 Median:66.50 stddev:10.05 (15.1%) stddev-sans-first:9.27 06:13:29 INFO - PROCESS | 1916 | Values: 82.0 59.0 62.0 87.0 69.0 57.0 63.0 62.0 74.0 64.0 06:13:29 INFO - PROCESS | 1916 | 06:13:29 INFO - PROCESS | 1916 | [#4] audio-oscillator Cycles:10 Average:86.90 Median:71.50 stddev:16.29 (22.8%) stddev-sans-first:17.18 06:13:29 INFO - PROCESS | 1916 | Values: 92.0 72.0 87.0 71.0 70.0 71.0 84.0 103.0 104.0 115.0 06:13:29 INFO - PROCESS | 1916 | 06:13:29 INFO - PROCESS | 1916 | [#5] imaging-gaussian-blur Cycles:10 Average:97.80 Median:88.00 stddev:12.54 (14.3%) stddev-sans-first:12.50 06:13:29 INFO - PROCESS | 1916 | Values: 110.0 124.0 88.0 105.0 104.0 88.0 89.0 88.0 95.0 87.0 06:13:29 INFO - PROCESS | 1916 | 06:13:29 INFO - PROCESS | 1916 | [#6] imaging-darkroom Cycles:10 Average:109.00 Median:97.00 stddev:21.48 (22.1%) stddev-sans-first:22.18 06:13:29 INFO - PROCESS | 1916 | Values: 95.0 97.0 97.0 126.0 98.0 158.0 129.0 97.0 97.0 96.0 06:13:29 INFO - PROCESS | 1916 | 06:13:29 INFO - PROCESS | 1916 | [#7] imaging-desaturate Cycles:10 Average:100.90 Median:91.00 stddev:19.25 (21.2%) stddev-sans-first:20.08 06:13:29 INFO - PROCESS | 1916 | Values: 91.0 106.0 88.0 93.0 89.0 91.0 95.0 91.0 115.0 150.0 06:13:29 INFO - PROCESS | 1916 | 06:13:29 INFO - PROCESS | 1916 | [#8] json-parse-financial Cycles:10 Average:68.40 Median:68.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 06:13:29 INFO - PROCESS | 1916 | Values: 68.0 69.0 68.0 68.0 68.0 69.0 68.0 69.0 68.0 69.0 06:13:29 INFO - PROCESS | 1916 | 06:13:29 INFO - PROCESS | 1916 | [#9] json-stringify-tinderbox Cycles:10 Average:58.90 Median:59.00 stddev:2.23 (3.8%) stddev-sans-first:2.24 06:13:29 INFO - PROCESS | 1916 | Values: 61.0 62.0 56.0 59.0 62.0 59.0 58.0 57.0 56.0 59.0 06:13:29 INFO - PROCESS | 1916 | 06:13:29 INFO - PROCESS | 1916 | [#10] stanford-crypto-aes Cycles:10 Average:89.10 Median:89.50 stddev:4.18 (4.7%) stddev-sans-first:4.00 06:13:29 INFO - PROCESS | 1916 | Values: 84.0 85.0 90.0 88.0 87.0 86.0 89.0 95.0 97.0 90.0 06:13:29 INFO - PROCESS | 1916 | 06:13:29 INFO - PROCESS | 1916 | [#11] stanford-crypto-ccm Cycles:10 Average:155.90 Median:158.00 stddev:9.05 (5.7%) stddev-sans-first:9.13 06:13:29 INFO - PROCESS | 1916 | Values: 148.0 159.0 160.0 151.0 144.0 146.0 172.0 155.0 167.0 157.0 06:13:29 INFO - PROCESS | 1916 | 06:13:29 INFO - PROCESS | 1916 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:199.70 Median:217.00 stddev:27.88 (12.9%) stddev-sans-first:26.22 06:13:29 INFO - PROCESS | 1916 | Values: 163.0 227.0 207.0 178.0 231.0 177.0 176.0 233.0 178.0 227.0 06:13:29 INFO - PROCESS | 1916 | 06:13:29 INFO - PROCESS | 1916 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.00 Median:76.00 stddev:10.53 (13.9%) stddev-sans-first:11.01 06:13:29 INFO - PROCESS | 1916 | Values: 71.0 66.0 68.0 67.0 67.0 73.0 79.0 83.0 94.0 92.0 06:13:29 INFO - PROCESS | 1916 | -------- Summary: end -------- 06:13:29 INFO - PROCESS | 1916 | 06:13:30 INFO - TEST-INFO | 1916: exit 0 06:13:30 INFO - TEST-OK | kraken | took 62655ms 06:13:30 INFO - SUITE-END | took 1179s 06:13:30 INFO - Completed test suite (00:19:39) 06:13:30 INFO - javascript benchmark 06:13:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7731.490699789476, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2869.3113652723355, 3452.5856897172334, 3472.2534655049158, 3477.5479187705596, 3497.038314463522, 4953.801847926083, 5792.855178620526, 5966.8806623867495, 6053.697315134242, 6060.090986352038, 5862.32583252926, 5933.288005439354, 5954.851128721784, 6008.158857759917, 6070.635761854292, 5238.659487133334, 5410.8917821643545, 5447.645903016311, 5469.617126801106, 5524.558035357162, 4568.5203053679215, 5340.0, 5490.890182196354, 5527.115661494162, 5571.164325351189, 4804.183288840871, 4959.784852711109, 5315.867103322448, 5453.182022696587, 5493.505584497374, 5406.189071639246, 5410.675359478444, 5434.402215756264, 5468.207109969072, 5486.039943009957, 4781.497942716, 5057.317262169597, 5362.168863826074, 5394.973025134888, 5449.346078470569, 5808.273965754281, 5839.211706419622, 5840.707964601753, 5913.645181289136, 6032.607880487754, 6282.811515654492, 6293.716782744787, 6307.117003619497, 6312.558120931537, 6377.5216858735785, 6433.163688720437, 6445.742170313182, 6449.774257900951, 6454.2900280969525, 6551.80344589663, 6043.637381757021, 6100.298465676459, 6129.662868542228, 6153.138560601519, 6156.6613836238985, 6317.241930968313, 6343.27052388972, 6468.482521398277, 6558.0, 6671.899921501182, 5688.573356998241, 6086.8130714511135, 6185.505159587222, 6248.250209974832, 6288.0, 6309.14826498426, 6315.810525684236, 6341.492680585542, 6389.584676995981, 6397.936020639827, 6317.905231421532, 6354.3963323484195, 6354.8411289717205, 6361.968190159112, 6364.326982667291, 6357.0, 6359.777407790705, 6365.045243213555, 6367.872642547123, 6383.808485745435, 5018.146915024455, 5067.46791586878, 5074.0, 5104.259882317117, 5120.820771272987, 4597.4712908015335, 4630.097131059479, 4632.884177895579, 4634.003689206769, 4675.018246168343, 6164.630122192682, 6171.59884607499, 6204.038374052029, 6219.657918814509, 6243.906341404882, 6273.9372606273355, 6283.0, 6384.744610215632, 6428.357164283628, 6478.255000674889, 6114.602550834182, 6115.301188036035, 6148.292946311231, 6149.538784591174, 6159.3224745277985, 5729.684867332254, 5731.111677689964, 5731.283589551306, 5739.311282646109, 5781.421857814269, 6366.872662546816, 6608.768693095719, 6709.597424154566, 6728.495362847708, 6730.495212859055, 6316.305206427198, 6318.652474113968, 6336.303006669171, 6336.809895703136, 6419.903701444576, 6380.266269378895, 6681.732730690913, 6716.496262780213, 6734.427573656294, 6745.5952642841585, 6310.463610593151, 6326.588771729823, 6349.396807303298, 6352.650604216812, 6455.677216139268, 5080.923786143285, 6255.530835187288, 6276.058591211172, 6305.495560355253, 6401.0, 5606.635568688022, 5981.930103256484, 6247.3440288769025, 6266.749330026748, 6288.937110629018, 6123.557162997564, 6150.80059388415, 6157.907631385443, 6243.8126856194385, 6288.088227207121, 6127.84680382994, 6134.04922237054, 6211.472024877755, 6232.719527621177, 6238.220222472191, 6257.906131407942, 6277.403646653561, 6279.340669229665, 6279.686015699105, 6294.968525157345, 6051.273847138372, 6077.331493535619, 6167.969160154171, 6189.102580125947, 6200.0699895016105], "value": 5869.412106874933, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [707.8407358344369, 735.9006534117894, 798.6485946183681, 932.622287973371, 938.5682586010431, 35965.2806943861, 38089.80955095224, 39792.40311395331, 39817.20365592687, 39843.0, 38128.23743525128, 38336.233275334474, 38347.808260958656, 38410.0, 38413.23173536535, 7679.424043196755, 7842.764717058469, 10784.029437350637, 11040.3375797452, 11173.273737207097, 10839.729006774814, 10942.726431839188, 10942.835857462145, 10954.507047182857, 10979.945100274488, 10910.399928003997, 10942.617008404708, 10948.945255273713, 10951.507182176781, 10953.780924381508, 10912.017918387344, 10919.235653504258, 10927.945360273226, 10935.781284374347, 10991.505382257817, 10710.571577136905, 10774.784504309948, 10779.191560632984, 10789.622363217328, 10816.0, 38253.42619860704, 38384.04039898997, 38502.80748596267, 38534.42198367027, 38580.421293680614, 3741.820345032697, 3758.229562939591, 3767.660910518039, 3798.5441746990264, 3834.65488106069, 27420.17739467819, 27752.889884404598, 28004.579931300843, 28119.718802811916, 28729.56905646417, 3106.8912588059534, 3131.85906634202, 3164.3671265746943, 3179.1104050834088, 3265.8203798791055, 338495.0, 340507.0, 343216.9999999975, 343700.0, 344733.0, 50426.74786626043, 50478.7380315495, 50664.49335506671, 50753.746231268604, 50832.237516437286, 51829.076237757356, 51948.18181363634, 52146.73926630418, 52173.478265216865, 52340.214896776575, 11580.88419115815, 14758.40966361355, 14806.0, 14817.851821481647, 14833.480828171178, 12006.939965300118, 12024.278543287432, 12038.75922481563, 12047.03623710101, 12064.879351206551, 13671.316434178252, 13743.931280343535, 13813.861861381258, 13905.930470347583, 13939.442422303197, 6020.638761674313, 6087.0, 6092.939070609237, 6104.11490333908, 6177.752889884354, 860.6428332242175, 905.3300557587338, 907.6233363154217, 927.9118483744033, 936.391345625349, 28210.43579128406, 28345.0, 28977.59649701563, 29059.837606495505, 29063.9827606037, 1037.83243850668, 1040.9843852342221, 1069.2408390043001, 1070.5343175718588, 1110.9777804443866, 11844.881551184379, 13398.330083495786, 14347.497837575635, 14643.194624295766, 14708.0, 469974.0, 471319.0, 471795.0, 475065.0, 476572.0, 52755.47244527505, 52759.94480110376, 52896.735516322944, 53155.73422132865, 53219.935601287754, 1184.8815118488255, 1384.0519244317875, 1415.8725714685727, 1419.474794326106, 1424.223798030076, 28960.855195723885, 29105.563416548346, 29404.70595294105, 29947.401051979276, 30066.549001764553, 45516.31725524054, 45665.0, 45763.0, 45799.542004580864, 45872.770636146604, 490931.0, 491464.0, 492500.0, 494095.0, 494364.0, 33653.49519757157, 34135.65864341325, 34441.82779086089, 34452.13869653179, 34482.31035379228, 42434.0, 42535.149297014505, 43190.78404608082, 43312.0, 43446.565534345515, 33646.49530257097, 35019.64980350164, 35081.298374032885, 36136.096597585274, 36180.63819361878, 34878.476822848184, 35258.647413525534, 35755.10612234715, 35956.92129236127, 36075.09812254715, 34405.655943440244, 34639.96080117601, 35385.46921796124, 35485.64514354926, 35732.0, 28621.856890715415, 30559.388812224075, 30617.0, 30627.08118756441, 30714.0, 22334.553308933406, 23179.97025285077, 23984.160554380513, 23998.331587127235, 24106.87946560256], "value": 19018.737682909574, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.8065941094754, 399.5804405374358, 406.57919053779335, 418.95600961899, 436.8230866499067, 18924.810751892477, 20514.794852051476, 21742.804145771977, 21841.563168736637, 21980.560388792215, 21449.785502144972, 21488.247911323106, 21646.783532164674, 21975.450613734665, 22136.557268854613, 6490.545661803664, 6662.500312476559, 6714.932850671479, 6738.898916516232, 6744.865102697943, 6313.368663133673, 6773.254941956381, 7159.4988350815465, 7468.0, 7631.961840190791, 7316.122065352165, 7610.277023682769, 7635.770926872175, 7642.312191902728, 7673.2326767323375, 7528.849423011537, 7602.049743782028, 7609.885851712229, 7629.961850190713, 7631.54210747357, 7093.8226544336285, 7285.380742636882, 7362.37419819316, 7363.558186508827, 7376.9262307376775, 25352.746472535222, 27162.913483460834, 27339.726602733917, 27343.316417089532, 27369.45261094767, 2637.907673231447, 2701.770349520293, 2738.219607411878, 2741.6024676422007, 3326.2017115892254, 15409.383624655, 15843.366265349372, 15862.920685396499, 16375.918120409322, 17066.061366624832, 2026.9695954560693, 2046.741254128715, 2052.158614967856, 2060.9072591733407, 2097.1611355457785, 133405.0, 140771.0, 162982.18508907498, 163813.0, 164206.0, 22709.318720438412, 23232.883835580713, 23451.648225276633, 23617.40956476102, 23781.167659131846, 35759.82120089383, 35778.821105894305, 35813.0, 35923.74266900646, 35930.0, 10602.57589696419, 10684.305520141166, 10870.782584348426, 10923.453827308604, 11218.270812397168, 8800.0, 8816.691415800417, 8822.779430514289, 8988.10118988096, 8995.32535059873, 9761.902380976242, 10724.839127413095, 10743.409112498732, 10842.674719758419, 10856.674299771019, 4019.457373254632, 4169.144730594917, 4246.129543443587, 4258.488981322199, 4285.0, 815.8368326334638, 961.9855702164473, 1030.05749738988, 1065.984010239847, 1101.7906597746403, 22450.88774556117, 22530.0, 22579.774202258097, 22628.208012719475, 22653.660195097087, 1028.18773169197, 1034.9741256468499, 1041.520900385831, 1048.6539441984128, 1083.6586475260267, 10915.727106822393, 10990.725231869108, 11801.940990294994, 11837.704057398634, 11859.822102668468, 689328.0, 696947.0, 698717.0, 712095.0, 717981.0, 141776.29111854374, 150935.0, 154583.0, 157549.212253938, 160565.0, 1031.1018514499667, 1225.381182502848, 1256.698392385839, 1258.4903114238748, 1260.5147018397984, 19633.31283405074, 19704.605907882047, 20007.299744508873, 20008.799472031726, 20088.59822803565, 46848.0, 61322.0, 61573.69213153906, 62140.37859621346, 62578.0, 86117.0, 86696.4977626668, 88187.67718484356, 88319.0, 89833.55083224803, 7580.583067931096, 10347.0, 10996.515470411392, 11817.468213930222, 12456.31490268044, 13423.932880335537, 13455.663608409868, 13838.308084595932, 13857.168569885838, 13989.790153147507, 10318.329308594917, 11448.599299024494, 11457.0, 11797.646070617895, 12030.27818330903, 10601.41692206936, 10764.838527422251, 10867.0, 11260.9436952818, 11760.0, 10872.184586155912, 11625.302481850778, 12061.216020958609, 12088.972437342924, 12184.329861857683, 11927.403629818647, 11973.820392693942, 12223.266604003788, 12239.265644061385, 12302.569410070604, 11511.942440287745, 11529.82705259405, 11817.172797904064, 11874.821877672015, 11956.402179890796], "value": 11920.242111976519, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1531.21142611555, 1549.1944189021715, 1555.4478160253109, 1572.096044774255, 1572.3081843988643, 10468.476576171199, 10933.945330273338, 11041.613543525978, 11102.666919992393, 11107.222494425394, 11174.66476005721, 11343.149263805206, 11349.773004539904, 11379.146564007691, 11407.973282404582, 1962.2249211561425, 2336.96494552581, 2337.91817286395, 2338.1816364272454, 2343.3087239264373, 2216.8115710164657, 2251.797338239558, 2254.4814692620707, 2257.413072601119, 2264.8980795864227, 2287.3481057898503, 2293.81649468043, 2300.2869110575693, 2310.676505289261, 2312.109837712476, 2266.841321107523, 2275.260540324393, 2282.167009041704, 2288.668143119247, 2308.4344335637793, 1883.4726276642562, 2321.6981792366882, 2324.070371851273, 2325.9767402326097, 2331.6852224949753, 10983.0, 11040.944795276053, 11043.171762117874, 11051.889481105167, 11083.667489975232, 5584.5253153482, 5744.109663002199, 5754.194412782172, 5759.510441612468, 5760.53915686744, 3308.536804847299, 3419.333230020147, 3611.801350925698, 3615.0, 3630.7458477906293, 1150.1718762490993, 1165.4289398194824, 1175.7354595216093, 1199.622119032502, 1221.0841868598552, 15150.621234469116, 15310.157941313224, 15412.30644621006, 15492.30284637194, 15501.0, 4346.630536404377, 4584.747838868828, 4605.907881842411, 4666.253399456071, 4707.646926480459, 11453.541858325574, 11513.194076414738, 11533.077353811675, 11553.364564949008, 11558.711032224262, 5564.610477266552, 5597.272354593958, 5609.0184217761725, 5615.9157612635845, 5618.213450116987, 4997.425296090923, 5111.412187598399, 5124.743762811844, 5138.640295179302, 5217.269582258411, 3765.4728338032696, 3793.639604237593, 3805.657490825839, 3889.0666240102737, 3892.338302488584, 870.1776820904184, 1019.6635110413546, 1024.5696807340935, 1040.3653771199563, 1041.1670663469195, 895.2166854002747, 920.231606608476, 925.1581061234244, 939.736873675372, 987.0672214756986, 6316.841777069513, 6351.174347334817, 6533.314002029719, 6622.4039836413995, 6648.900266496006, 787.7715462515806, 822.321584692631, 935.9672411465566, 938.4697645830084, 981.5239608789731, 3783.243351329745, 4061.89845253871, 4094.303968325392, 4207.474065741782, 4208.831646734157, 12963.805542916863, 13473.86526134726, 13698.863011369758, 13706.794398084037, 13741.793873091912, 12810.359482025862, 13613.183209007491, 13630.591082267549, 13650.249236292098, 13677.0, 7575.393968482618, 9112.22546083577, 9123.726288211365, 9160.496172710431, 9214.078592140866, 6659.966700166468, 6715.7985260442265, 6753.189617245962, 6884.139482564679, 6916.20463646687, 11578.363190024293, 11977.401129943293, 12190.634280971584, 12205.633830985085, 12212.130149414703, 10202.183825294107, 11777.52889884395, 12237.265764054186, 12243.57147499869, 12263.202891812003, 8368.874466883124, 9242.260619150586, 9265.119813617695, 9428.057194280516, 9451.669191578261, 9066.138716821892, 10037.297389182688, 10464.63373781914, 10552.947235263775, 10622.415767132881, 8102.432829701865, 9053.094690530894, 9069.909300906906, 9439.716808495756, 9802.019798020141, 8875.378723489552, 9380.0, 9521.238300936047, 9524.619015239312, 9560.952195238979, 7799.18108598589, 7883.7240696575345, 7957.880631790412, 7966.3626909848235, 7973.481723687942, 5679.977604031314, 5869.383714709894, 5993.790217342372, 6055.061465472859, 6120.357362477054, 5914.763409463573, 5969.552283578662, 6016.669083200466, 6025.66858822769, 6126.977522858522], "value": 5048.664636863696, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.823858667133, 380.38187944590044, 384.68840239406086, 389.33423845224655, 391.05365016659664, 5202.820108250618, 5257.500537448946, 5295.31160949077, 5324.8019195681, 5364.865878353043, 4490.910181796362, 4883.340748998884, 4915.483874193203, 5237.319148510698, 5245.423003469616, 3968.968068302248, 3969.8610548630804, 4186.958130418688, 4301.8064187111495, 4328.891777705551, 3950.6641935435523, 4377.846775362863, 4393.846215382462, 4409.9934529789025, 4444.866654000385, 3837.961620383788, 3909.569947305794, 4355.912881742363, 4365.140832754535, 4397.978010109961, 3491.8302368706513, 3576.998440436656, 3755.830987605564, 4408.493023302329, 4428.557144285562, 3442.9326908658395, 3816.3589656447716, 3915.4322623219473, 3939.7439166454374, 3991.381335892941, 4392.231359512072, 4468.82124715011, 4585.518520555361, 4625.838095666635, 5070.797168113271, 4232.8518501852595, 4245.724027938205, 4567.840125595621, 5010.549050585429, 5088.872778180538, 4958.380202474691, 4980.452150263504, 5167.354080739908, 5167.612429067835, 5568.693721845297, 3769.905752356213, 4158.981049642826, 4247.600105940134, 4450.863585478955, 4494.9775251123865, 5134.358205224347, 5329.907368989348, 5603.551715862721, 5978.491828194608, 6001.789937352215, 3687.778733276012, 3773.547184334051, 4057.431959525669, 4152.024274295538, 4610.700304480198, 4138.8551400700835, 4641.327007583882, 4648.0, 4666.743329116864, 4668.6965347253, 4246.8533495956535, 4986.376702912136, 5000.224965130411, 5021.322121513622, 5032.018756342552, 5410.702411367412, 5542.445755424425, 5565.860853478695, 5579.6652200868075, 5594.524465420485, 1458.4166333466485, 1472.4404726203975, 1481.4370539195038, 1485.3093311610153, 1554.8678362339328, 1084.7505073833063, 1124.533318672758, 1127.763169734365, 1161.5353858456515, 1188.9834191766088, 4591.701539399928, 5034.521720436553, 5161.122609156378, 5169.896602067937, 5184.974075129676, 5034.723090229999, 5266.657667251617, 5804.535637149018, 5807.303123625107, 5810.477057064884, 4237.8304867804945, 4791.0, 4891.510848915151, 4897.951020489821, 5141.691498510027, 2582.5093232285803, 2821.3228825081833, 2964.688707685705, 2979.6722360540325, 2987.191331052925, 5242.0, 5641.379448260688, 5905.704714764244, 5943.31651860033, 5975.43233392827, 4939.925901111486, 5365.195220716846, 5390.757415916215, 5402.0, 5581.832545023656, 5274.7626356814035, 5471.2887324647545, 5618.831435056954, 5816.214811000461, 6052.848678783065, 5054.848354549369, 5086.33877595925, 5757.740901659519, 5823.301203855564, 5843.208568973401, 4916.680415772963, 5273.574155888335, 5543.334799824047, 5743.8564035899435, 5793.391693872083, 4880.804767809248, 5427.48438898304, 5735.971320143372, 5890.846952898282, 6124.969375153096, 4416.006398560298, 4580.602916110618, 4617.930731039104, 4641.767911604339, 4657.953420465752, 4722.693024953367, 5391.514763671288, 5520.944790552043, 5640.88718225625, 5832.687645279948, 5353.848922481685, 5436.429174936575, 5631.267935168402, 5693.149726338874, 5732.684702341245, 4825.662203645711, 4862.82980095695, 5223.0, 5603.467670571289, 5674.404187560247, 4861.878453038702, 5405.378381486179, 5433.347998240237, 5486.561075114061, 5489.451054894478, 5059.494050594911, 5178.0, 5236.816711415235, 5503.734141147478, 5622.449845929446, 4907.288443175791, 5145.228215767665, 5506.091494903296, 5506.475855452593, 5552.114758356155], "value": 4213.209873585658, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [595.5354823237876, 728.078980090186, 728.8797348437507, 766.4136935244535, 857.2070834478108, 15019.474318398858, 16011.719062474975, 16029.519114426557, 16149.192540372978, 16185.35258589655, 14600.926995365035, 15123.0, 15151.469698560553, 15275.847241527581, 15277.69444611107, 906.9773255668595, 944.6740874398356, 944.7449188719041, 949.5204921514626, 950.9001554836747, 931.161954241185, 939.3893968920188, 939.492673956063, 939.5959737312953, 955.0878910640322, 1020.5968642386252, 1027.9177665786756, 1029.6756521695643, 1031.0926384781383, 1032.6282538286248, 1015.8069966706377, 1020.4285600063951, 1026.1021606094666, 1026.630413051301, 1027.1372047480115, 748.9325960663512, 755.1919446192576, 760.232165512836, 761.090496856257, 763.6258233465618, 15930.840691593052, 16391.672166556604, 16413.261403236884, 16835.989840609604, 17168.0, 14101.506447274296, 14233.50182743599, 14245.430182792676, 14282.85717142836, 14348.784768228485, 9918.80162396748, 11522.827157592643, 11764.235324703952, 11786.410679465993, 12266.018718502499, 3679.632036796326, 3688.0964163779777, 3719.2933342664805, 3722.758020728644, 3808.4668146459517, 94661.05338946592, 114403.0, 116183.41908290405, 116243.67512649784, 117878.82121178764, 9581.856272155923, 11214.383208923588, 11235.101191904629, 11727.0, 11766.529338826522, 24805.0, 25003.37491562689, 25116.24651260465, 25141.622875656878, 25250.989960401377, 6820.727170913207, 7806.6096695165015, 7870.72452464161, 7913.089994650689, 8015.879761803578, 4224.685043099393, 4232.246254253141, 4238.957610423918, 4248.235317642792, 4313.137999512263, 3499.4051011328133, 3542.3800834854314, 3574.21367299199, 3577.0, 3590.551181102362, 630.574362305442, 634.6858305138893, 637.4549759955172, 650.8437974886087, 651.1892693596408, 582.939567271823, 640.7789312687115, 676.9763058292937, 690.7450107338769, 703.63762662229, 9095.590183521565, 10051.949740251399, 10241.692749217535, 10260.025297596716, 10459.895401045893, 659.7328082126746, 673.0, 677.4140368581241, 684.4011489946297, 703.9472039597051, 4633.374494443275, 4926.778294976734, 4930.186519224288, 4943.90112197754, 4967.180415231519, 104319.0, 105035.4748226254, 106051.87896242186, 107153.4642326799, 108272.45863770631, 91051.0, 91673.0, 92392.61411078839, 93987.0, 94238.0, 77611.61194193993, 78568.60715696384, 79100.0, 79478.60260698776, 80746.59626701829, 9347.896723237218, 9527.142557169887, 9543.997880222754, 9613.213297229267, 9717.416954982724, 52155.0, 52340.73829630828, 52552.47447525629, 53592.73203634113, 54423.0, 53933.46066539284, 69153.65423173053, 69709.0, 70180.29819701737, 70471.29528704648, 11652.592159274385, 11748.876697365999, 11778.0, 11837.82243266369, 12420.378981051092, 12739.171953822972, 12844.935775321064, 12948.0, 12987.155834870704, 13125.868741312846, 10663.0, 11145.2198346115, 11890.16768826174, 11924.105692072955, 12145.57490487864, 10361.896381036093, 11820.70448238801, 11873.0, 12263.38683065861, 12680.6829829255, 10128.44293563861, 11539.711507212387, 11628.592999244986, 11670.649880503599, 11870.0, 10179.515308666778, 10215.438150901475, 10241.18070554339, 10491.895081049091, 10583.512874474338, 8660.220580147565, 9005.459672419676, 9992.600295988079, 10009.199264058712, 10044.045815647502], "value": 7545.457318820026, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1586.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 178.0, 119.0, 120.0, 119.0, 119.0, 119.0, 119.0, 118.0, 119.0], "value": 125.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 140.0, 111.0, 157.0, 115.0, 114.0, 114.0, 116.0, 138.0, 116.0], "value": 128.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 214.0, 211.0, 244.0, 228.0, 202.0, 198.0, 246.0, 288.0, 197.0], "value": 222.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 59.0, 62.0, 87.0, 69.0, 57.0, 63.0, 62.0, 74.0, 64.0], "value": 67.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 72.0, 87.0, 71.0, 70.0, 71.0, 84.0, 103.0, 104.0, 115.0], "value": 86.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 124.0, 88.0, 105.0, 104.0, 88.0, 89.0, 88.0, 95.0, 87.0], "value": 97.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 97.0, 126.0, 98.0, 158.0, 129.0, 97.0, 97.0, 96.0], "value": 109.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 106.0, 88.0, 93.0, 89.0, 91.0, 95.0, 91.0, 115.0, 150.0], "value": 100.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 68.0, 68.0, 68.0, 69.0, 68.0, 69.0, 68.0, 69.0], "value": 68.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 56.0, 59.0, 62.0, 59.0, 58.0, 57.0, 56.0, 59.0], "value": 58.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 90.0, 88.0, 87.0, 86.0, 89.0, 95.0, 97.0, 90.0], "value": 89.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 159.0, 160.0, 151.0, 144.0, 146.0, 172.0, 155.0, 167.0, 157.0], "value": 155.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 227.0, 207.0, 178.0, 231.0, 177.0, 176.0, 233.0, 178.0, 227.0], "value": 199.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 66.0, 68.0, 67.0, 67.0, 73.0, 79.0, 83.0, 94.0, 92.0], "value": 76.0, "unit": "score"}]}]} 06:13:30 INFO - Return code: 0 06:13:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:13:30 ERROR - # TBPL SUCCESS # 06:13:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:13:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:13:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:13:30 INFO - 2017-03-09 06:13:30.902 screenresolution[1921:24132] starting screenresolution argv=screenresolution get 06:13:30 INFO - 2017-03-09 06:13:30.905 screenresolution[1921:24132] Display 0: 1600x1200x32@60 06:13:30 INFO - 2017-03-09 06:13:30.911 screenresolution[1922:24135] starting screenresolution argv=screenresolution list 06:13:30 INFO - Available Modes on Display 0 06:13:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:13:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:13:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:13:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:13:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:13:31 INFO - Intel Iris: 06:13:31 INFO - Chipset Model: Intel Iris 06:13:31 INFO - Type: GPU 06:13:31 INFO - Bus: Built-In 06:13:31 INFO - VRAM (Dynamic, Max): 1536 MB 06:13:31 INFO - Vendor: Intel (0x8086) 06:13:31 INFO - Device ID: 0x0a2e 06:13:31 INFO - Revision ID: 0x0009 06:13:31 INFO - Displays: 06:13:31 INFO - Display: 06:13:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:13:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:13:31 INFO - Display Serial Number: 1600x1200 60 06:13:31 INFO - Main Display: Yes 06:13:31 INFO - Mirror: Off 06:13:31 INFO - Online: Yes 06:13:31 INFO - Rotation: Supported 06:13:31 INFO - Return code: 0 06:13:31 INFO - Running post-action listener: _resource_record_post_action 06:13:31 INFO - [mozharness: 2017-03-09 14:13:31.146794Z] Finished run-tests step (success) 06:13:31 INFO - Running post-run listener: _resource_record_post_run 06:13:31 INFO - Total resource usage - Wall time: 1200s; CPU: 55.0%; Read bytes: 2049024; Write bytes: 514538496; Read time: 21; Write time: 1752 06:13:31 INFO - TinderboxPrint: CPU usage
55.1% 06:13:31 INFO - TinderboxPrint: I/O read bytes / time
2,049,024 / 21 06:13:31 INFO - TinderboxPrint: I/O write bytes / time
514,538,496 / 1,752 06:13:31 INFO - TinderboxPrint: CPU idle
2,156.8 (44.9%) 06:13:31 INFO - TinderboxPrint: CPU system
970.8 (20.2%) 06:13:31 INFO - TinderboxPrint: CPU user
1,674.1 (34.9%) 06:13:31 INFO - TinderboxPrint: Swap in / out
212,578,304 / 0 06:13:31 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 203069952; Write bytes: 203184128; Read time: 15502; Write time: 432 06:13:31 INFO - run-tests - Wall time: 1181s; CPU: 55.0%; Read bytes: 2049024; Write bytes: 300585984; Read time: 21; Write time: 1289 06:13:31 INFO - Running post-run listener: _upload_blobber_files 06:13:31 INFO - Blob upload gear active. 06:13:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:13:31 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:13:31 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:13:31 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:13:32 INFO - (blobuploader) - INFO - Open directory for files ... 06:13:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:13:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:13:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:13:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:13:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:13:33 INFO - (blobuploader) - INFO - Done attempting. 06:13:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:13:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:13:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:13:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:13:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:13:35 INFO - (blobuploader) - INFO - Done attempting. 06:13:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 06:13:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:13:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:13:36 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 06:13:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:13:36 INFO - (blobuploader) - INFO - Done attempting. 06:13:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:13:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:13:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:13:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:13:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:13:38 INFO - (blobuploader) - INFO - Done attempting. 06:13:38 INFO - (blobuploader) - INFO - Iteration through files over. 06:13:38 INFO - Return code: 0 06:13:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:13:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:13:38 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f7fcbe5acb4b7e328472f50b63d1cb735c7d56870f034aaba8beae0e76ec969656621526fbf30b87f9bed01c25e16e950a4d0f372a0216e2e3aa39e132c3218a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd29d89d2a1ed131b3fa01f1dfaaee9e8c06389767f7372969e88783150f52aaee05fe3b08ff5ff329bfceb0b81d8c4a086ecd51cc6880e059beda55832a6665", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/27ef91f0bf92c1af4b492910f4bcb12c6e77dc29149780f0fb79b061b97cccd2319c30aebb942dc3f3b86695ac1b10795e1d4bbc666b1cf0ee82847b086dbb27", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/943002e7409bf8120b1416773b5025321d29c4f0bd1790cadb97639fb09a1ddf6d212188d3f76870017b2d059b84a7c58079c8893591cd8aeadb8d31da0105aa"} 06:13:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:13:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:13:38 INFO - Contents: 06:13:38 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f7fcbe5acb4b7e328472f50b63d1cb735c7d56870f034aaba8beae0e76ec969656621526fbf30b87f9bed01c25e16e950a4d0f372a0216e2e3aa39e132c3218a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd29d89d2a1ed131b3fa01f1dfaaee9e8c06389767f7372969e88783150f52aaee05fe3b08ff5ff329bfceb0b81d8c4a086ecd51cc6880e059beda55832a6665", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/27ef91f0bf92c1af4b492910f4bcb12c6e77dc29149780f0fb79b061b97cccd2319c30aebb942dc3f3b86695ac1b10795e1d4bbc666b1cf0ee82847b086dbb27", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/943002e7409bf8120b1416773b5025321d29c4f0bd1790cadb97639fb09a1ddf6d212188d3f76870017b2d059b84a7c58079c8893591cd8aeadb8d31da0105aa"} 06:13:38 INFO - Running post-run listener: copy_logs_to_upload_dir 06:13:38 INFO - Copying logs to upload dir... 06:13:38 INFO - mkdir: /builds/slave/test/build/upload/logs 06:13:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1284.582555 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-03-09 06:13:38.414571) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-09 06:13:38.418123) ========= 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.6Eadmebxvx/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.WkfaLVBQ9A/Listeners TMPDIR=/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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/f7fcbe5acb4b7e328472f50b63d1cb735c7d56870f034aaba8beae0e76ec969656621526fbf30b87f9bed01c25e16e950a4d0f372a0216e2e3aa39e132c3218a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd29d89d2a1ed131b3fa01f1dfaaee9e8c06389767f7372969e88783150f52aaee05fe3b08ff5ff329bfceb0b81d8c4a086ecd51cc6880e059beda55832a6665", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/27ef91f0bf92c1af4b492910f4bcb12c6e77dc29149780f0fb79b061b97cccd2319c30aebb942dc3f3b86695ac1b10795e1d4bbc666b1cf0ee82847b086dbb27", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/943002e7409bf8120b1416773b5025321d29c4f0bd1790cadb97639fb09a1ddf6d212188d3f76870017b2d059b84a7c58079c8893591cd8aeadb8d31da0105aa"} build_url:https://queue.taskcluster.net/v1/task/HodiXT-GSXqvSq42qHGX0A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011085 build_url: 'https://queue.taskcluster.net/v1/task/HodiXT-GSXqvSq42qHGX0A/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/f7fcbe5acb4b7e328472f50b63d1cb735c7d56870f034aaba8beae0e76ec969656621526fbf30b87f9bed01c25e16e950a4d0f372a0216e2e3aa39e132c3218a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd29d89d2a1ed131b3fa01f1dfaaee9e8c06389767f7372969e88783150f52aaee05fe3b08ff5ff329bfceb0b81d8c4a086ecd51cc6880e059beda55832a6665", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/27ef91f0bf92c1af4b492910f4bcb12c6e77dc29149780f0fb79b061b97cccd2319c30aebb942dc3f3b86695ac1b10795e1d4bbc666b1cf0ee82847b086dbb27", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/943002e7409bf8120b1416773b5025321d29c4f0bd1790cadb97639fb09a1ddf6d212188d3f76870017b2d059b84a7c58079c8893591cd8aeadb8d31da0105aa"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-09 06:13:38.452980) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-09 06:13:38.453273) ========= 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.6Eadmebxvx/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.WkfaLVBQ9A/Listeners TMPDIR=/var/folders/8q/1qn5byls3hb2_j9sdd_5df0000000w/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.005277 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-09 06:13:38.501314) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-09 06:13:38.501603) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-09 06:13:38.501921) ========= ========= Total master_lag: 1.98 =========