builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0181 starttime: 1490120243.02 results: success (0) buildid: 20170321092323 builduid: 962451bdcb7a4cfea38ac0d989a13a77 revision: 9fb5e850ab7ab0b2b90640c604f66038407b411d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-21 11:17:23.017344) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-21 11:17:23.017789) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-21 11:17:23.018074) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-21 11:17:23.049884) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 11:17:23.050313) ========= 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.YFy4gx0Kd1/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.9h6eWAtNF2/Listeners TMPDIR=/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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-21 11:17:23-- 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% 15.1M=0.001s 2017-03-21 11:17:23 (15.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.337288 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 11:17:23.411811) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 11:17:23.412135) ========= 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.YFy4gx0Kd1/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.9h6eWAtNF2/Listeners TMPDIR=/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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.027609 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 11:17:23.461712) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-21 11:17:23.462300) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9fb5e850ab7ab0b2b90640c604f66038407b411d --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 9fb5e850ab7ab0b2b90640c604f66038407b411d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.YFy4gx0Kd1/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.9h6eWAtNF2/Listeners TMPDIR=/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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-21 11:17:23,570 truncating revision to first 12 chars 2017-03-21 11:17:23,570 Setting DEBUG logging. 2017-03-21 11:17:23,570 attempt 1/10 2017-03-21 11:17:23,570 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9fb5e850ab7a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-21 11:17:24,971 unpacking tar archive at: mozilla-central-9fb5e850ab7a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.667605 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-21 11:17:25.155710) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-21 11:17:25.156057) ========= script_repo_revision: 9fb5e850ab7ab0b2b90640c604f66038407b411d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-21 11:17:25.156472) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-21 11:17:25.156761) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-21 11:17:25.179113) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-03-21 11:17:25.179765) ========= /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.YFy4gx0Kd1/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.9h6eWAtNF2/Listeners TMPDIR=/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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 11:17:25 INFO - MultiFileLogger online at 20170321 11:17:25 in /builds/slave/test 11:17:25 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 11:17:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:17:25 INFO - {'append_to_log': False, 11:17:25 INFO - 'base_work_dir': '/builds/slave/test', 11:17:25 INFO - 'blob_upload_branch': 'Firefox', 11:17:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:17:25 INFO - 'branch': 'Firefox', 11:17:25 INFO - 'buildbot_json_path': 'buildprops.json', 11:17:25 INFO - 'config_files': ('talos/mac_config.py',), 11:17:25 INFO - 'default_actions': ('clobber', 11:17:25 INFO - 'read-buildbot-config', 11:17:25 INFO - 'download-and-extract', 11:17:25 INFO - 'populate-webroot', 11:17:25 INFO - 'create-virtualenv', 11:17:25 INFO - 'install', 11:17:25 INFO - 'run-tests'), 11:17:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:17:25 INFO - 'download_minidump_stackwalk': True, 11:17:25 INFO - 'download_symbols': 'ondemand', 11:17:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:17:25 INFO - 'tooltool.py': '/tools/tooltool.py', 11:17:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:17:25 INFO - '/tools/misc-python/virtualenv.py')}, 11:17:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:17:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:17:25 INFO - 'gecko_profile': False, 11:17:25 INFO - 'gecko_profile_interval': 0, 11:17:25 INFO - 'installer_path': 'installer.exe', 11:17:25 INFO - 'log_level': 'info', 11:17:25 INFO - 'log_name': 'talos', 11:17:25 INFO - 'log_to_console': True, 11:17:25 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:17:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:17:25 INFO - 'opt_config_files': (), 11:17:25 INFO - 'pip_index': False, 11:17:25 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:17:25 INFO - 'cmd': ('bash', 11:17:25 INFO - '-c', 11:17:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:17:25 INFO - 'enabled': True, 11:17:25 INFO - 'halt_on_failure': False, 11:17:25 INFO - 'name': 'check_screen_resolution'},), 11:17:25 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:17:25 INFO - 'cmd': ('bash', 11:17:25 INFO - '-c', 11:17:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:17:25 INFO - 'enabled': True, 11:17:25 INFO - 'halt_on_failure': False, 11:17:25 INFO - 'name': 'check_screen_resolution'},), 11:17:25 INFO - 'run_cmd_checks_enabled': True, 11:17:25 INFO - 'suite': 'dromaeojs-e10s', 11:17:25 INFO - 'system_bits': '32', 11:17:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:17:25 INFO - 'title': 't-yosemite-r7-0181', 11:17:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:17:25 INFO - 'use_talos_json': True, 11:17:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:17:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:17:25 INFO - 'work_dir': 'build'} 11:17:25 INFO - [mozharness: 2017-03-21 18:17:25.402513Z] Running clobber step. 11:17:25 INFO - Running pre-action listener: _resource_record_pre_action 11:17:25 INFO - Running main action method: clobber 11:17:25 INFO - rmtree: /builds/slave/test/build 11:17:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:17:27 INFO - Running post-action listener: _resource_record_post_action 11:17:27 INFO - [mozharness: 2017-03-21 18:17:27.997403Z] Finished clobber step (success) 11:17:27 INFO - [mozharness: 2017-03-21 18:17:27.997650Z] Running read-buildbot-config step. 11:17:27 INFO - Running pre-action listener: _resource_record_pre_action 11:17:27 INFO - Running main action method: read_buildbot_config 11:17:27 INFO - Using buildbot properties: 11:17:27 INFO - { 11:17:27 INFO - "project": "", 11:17:27 INFO - "product": "firefox", 11:17:27 INFO - "script_repo_revision": "production", 11:17:27 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 11:17:27 INFO - "repository": "", 11:17:27 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 11:17:28 INFO - "buildid": "20170321092323", 11:17:28 INFO - "pgo_build": "False", 11:17:28 INFO - "basedir": "/builds/slave/test", 11:17:28 INFO - "buildnumber": 14, 11:17:28 INFO - "slavename": "t-yosemite-r7-0181", 11:17:28 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 11:17:28 INFO - "platform": "yosemite_r7", 11:17:28 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 11:17:28 INFO - "branch": "mozilla-central", 11:17:28 INFO - "repo_path": "mozilla-central", 11:17:28 INFO - "revision": "9fb5e850ab7ab0b2b90640c604f66038407b411d", 11:17:28 INFO - "stage_platform": "macosx64", 11:17:28 INFO - "builduid": "962451bdcb7a4cfea38ac0d989a13a77", 11:17:28 INFO - "slavebuilddir": "test" 11:17:28 INFO - } 11:17:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/DpJ_0uuqQfyqN9k8ZTvquw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 11:17:28 INFO - Running post-action listener: _resource_record_post_action 11:17:28 INFO - [mozharness: 2017-03-21 18:17:28.003376Z] Finished read-buildbot-config step (success) 11:17:28 INFO - [mozharness: 2017-03-21 18:17:28.003575Z] Running download-and-extract step. 11:17:28 INFO - Running pre-action listener: _resource_record_pre_action 11:17:28 INFO - Running main action method: download_and_extract 11:17:28 INFO - mkdir: /builds/slave/test/build/tests 11:17:28 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')]} 11:17:28 INFO - trying https://queue.taskcluster.net/v1/task/DpJ_0uuqQfyqN9k8ZTvquw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 11:17:28 INFO - Downloading https://queue.taskcluster.net/v1/task/DpJ_0uuqQfyqN9k8ZTvquw/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 11:17:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DpJ_0uuqQfyqN9k8ZTvquw/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 11:17:29 INFO - Downloaded 1325 bytes. 11:17:29 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 11:17:29 INFO - Using the following test package requirements: 11:17:29 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 11:17:29 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 11:17:29 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 11:17:29 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 11:17:29 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 11:17:29 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 11:17:29 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 11:17:29 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 11:17:29 INFO - u'jsshell-mac.zip'], 11:17:29 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 11:17:29 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 11:17:29 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 11:17:29 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 11:17:29 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 11:17:29 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 11:17:29 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 11:17:29 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 11:17:29 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 11:17:29 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 11:17:29 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 11:17:29 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 11:17:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DpJ_0uuqQfyqN9k8ZTvquw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 11:17:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DpJ_0uuqQfyqN9k8ZTvquw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:17:29 INFO - Fetch https://queue.taskcluster.net/v1/task/DpJ_0uuqQfyqN9k8ZTvquw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 11:17:30 INFO - Expected file size: 52475931 11:17:30 INFO - Obtained file size: 52475931 11:17:47 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 11:17:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DpJ_0uuqQfyqN9k8ZTvquw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 11:17:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DpJ_0uuqQfyqN9k8ZTvquw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:17:47 INFO - Fetch https://queue.taskcluster.net/v1/task/DpJ_0uuqQfyqN9k8ZTvquw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 11:17:48 INFO - Expected file size: 52475931 11:17:48 INFO - Obtained file size: 52475931 11:18:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DpJ_0uuqQfyqN9k8ZTvquw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 11:18:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DpJ_0uuqQfyqN9k8ZTvquw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 11:18:03 INFO - Fetch https://queue.taskcluster.net/v1/task/DpJ_0uuqQfyqN9k8ZTvquw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 11:18:05 INFO - Expected file size: 14404171 11:18:05 INFO - Obtained file size: 14404171 11:18: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')]} 11:18:05 INFO - trying https://queue.taskcluster.net/v1/task/DpJ_0uuqQfyqN9k8ZTvquw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 11:18:05 INFO - Downloading https://queue.taskcluster.net/v1/task/DpJ_0uuqQfyqN9k8ZTvquw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 11:18:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DpJ_0uuqQfyqN9k8ZTvquw/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 11:18:07 INFO - Downloaded 75233548 bytes. 11:18:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DpJ_0uuqQfyqN9k8ZTvquw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 11:18:07 INFO - mkdir: /builds/slave/test/properties 11:18:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:18:07 INFO - Writing to file /builds/slave/test/properties/build_url 11:18:07 INFO - Contents: 11:18:07 INFO - build_url:https://queue.taskcluster.net/v1/task/DpJ_0uuqQfyqN9k8ZTvquw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 11:18:08 INFO - Running post-action listener: _resource_record_post_action 11:18:08 INFO - Running post-action listener: set_extra_try_arguments 11:18:08 INFO - [mozharness: 2017-03-21 18:18:08.222573Z] Finished download-and-extract step (success) 11:18:08 INFO - [mozharness: 2017-03-21 18:18:08.222692Z] Running populate-webroot step. 11:18:08 INFO - Running pre-action listener: _resource_record_pre_action 11:18:08 INFO - Running main action method: populate_webroot 11:18:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:18:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:18:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:18:08 INFO - '--tppagecycles', 11:18:08 INFO - '7'], 11:18:08 INFO - 'tests': ['tsvgm']}}, 11:18:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:18:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:18:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:18:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:18:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:18:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:18:08 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 11:18:08 INFO - 'talos_options': ['--disable-e10s'], 11:18:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:18:08 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:18:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:18:08 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 11:18:08 INFO - 'talos_options': ['--disable-e10s'], 11:18:08 INFO - 'tests': ['damp', 'tps']}, 11:18:08 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:18:08 INFO - 'tests': ['damp', 'tps']}, 11:18:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:18:08 INFO - 'tests': ['dromaeo_dom']}, 11:18:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:18:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:18:08 INFO - 'tests': ['basic_compositor_video']}, 11:18:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:18:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:18:08 INFO - 'tests': ['a11yr', 11:18:08 INFO - 'ts_paint', 11:18:08 INFO - 'tpaint', 11:18:08 INFO - 'sessionrestore', 11:18:08 INFO - 'sessionrestore_no_auto_restore', 11:18:08 INFO - 'tabpaint']}, 11:18:08 INFO - 'other-e10s': {'tests': ['a11yr', 11:18:08 INFO - 'ts_paint', 11:18:08 INFO - 'tpaint', 11:18:08 INFO - 'sessionrestore', 11:18:08 INFO - 'sessionrestore_no_auto_restore', 11:18:08 INFO - 'tabpaint']}, 11:18:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:18:08 INFO - 'ts_paint', 11:18:08 INFO - 'tpaint', 11:18:08 INFO - 'sessionrestore', 11:18:08 INFO - 'sessionrestore_no_auto_restore', 11:18:08 INFO - 'tabpaint']}, 11:18:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:18:08 INFO - 'ts_paint', 11:18:08 INFO - 'tpaint', 11:18:08 INFO - 'sessionrestore', 11:18:08 INFO - 'sessionrestore_no_auto_restore', 11:18:08 INFO - 'tabpaint']}, 11:18:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:18:08 INFO - 'tests': ['a11yr', 11:18:08 INFO - 'ts_paint', 11:18:08 INFO - 'tpaint', 11:18:08 INFO - 'sessionrestore', 11:18:08 INFO - 'sessionrestore_no_auto_restore', 11:18:08 INFO - 'tabpaint']}, 11:18:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:18:08 INFO - 'tests': ['a11yr', 11:18:08 INFO - 'ts_paint', 11:18:08 INFO - 'tpaint', 11:18:08 INFO - 'sessionrestore', 11:18:08 INFO - 'sessionrestore_no_auto_restore', 11:18:08 INFO - 'tabpaint']}, 11:18:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:18:08 INFO - 'tests': ['tsvgx', 11:18:08 INFO - 'tsvgr_opacity', 11:18:08 INFO - 'tart', 11:18:08 INFO - 'tscrollx', 11:18:08 INFO - 'cart', 11:18:08 INFO - 'tsvg_static']}, 11:18:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:18:08 INFO - 'tsvgr_opacity', 11:18:08 INFO - 'tart', 11:18:08 INFO - 'tscrollx', 11:18:08 INFO - 'cart', 11:18:08 INFO - 'tsvg_static']}, 11:18:08 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 11:18:08 INFO - 'talos_options': ['--disable-e10s'], 11:18:08 INFO - 'tests': ['tp5o']}, 11:18:08 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:18:08 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 11:18:08 INFO - 'talos_options': ['--disable-e10s', 11:18:08 INFO - '--xperf_path', 11:18:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:18:08 INFO - 'tests': ['tp5n']}, 11:18:08 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:18:08 INFO - 'talos_options': ['--xperf_path', 11:18:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:18:08 INFO - 'tests': ['tp5n']}}, 11:18:08 INFO - 'talos.zip': {'path': '', 11:18:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:18:08 INFO - Running post-action listener: _resource_record_post_action 11:18:08 INFO - [mozharness: 2017-03-21 18:18:08.241045Z] Finished populate-webroot step (success) 11:18:08 INFO - [mozharness: 2017-03-21 18:18:08.241173Z] Running create-virtualenv step. 11:18:08 INFO - Running pre-action listener: _resource_record_pre_action 11:18:08 INFO - Running main action method: create_virtualenv 11:18:08 INFO - Creating virtualenv /builds/slave/test/build/venv 11:18:08 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 11:18:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:18:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:18:08 INFO - Using real prefix '/tools/python27' 11:18:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:18:09 INFO - Installing distribute.............................................................................................................................................................................................done. 11:18:11 INFO - Installing pip.................done. 11:18:11 INFO - Return code: 0 11:18:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:18:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:18:12 INFO - Reading from file tmpfile_stdout 11:18:12 INFO - Output received: 11:18:12 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) 11:18:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:18:12 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')]} 11:18:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:12 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')]} 11:18:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:12 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 0x106efcb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106eff768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8322cb5190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cdad30>, '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 0x106c01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ccfbe8>, '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.YFy4gx0Kd1/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.9h6eWAtNF2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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 11:18:12 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 11:18:12 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 11:18:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YFy4gx0Kd1/Render', 11:18:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:18:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:18:12 INFO - 'HOME': '/Users/cltbld', 11:18:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:18:12 INFO - 'LOGNAME': 'cltbld', 11:18:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:12 INFO - 'MOZ_NO_REMOTE': '1', 11:18:12 INFO - 'NO_EM_RESTART': '1', 11:18:12 INFO - 'PAGER': '/bin/cat', 11:18:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:18:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:12 INFO - 'PWD': '/builds/slave/test', 11:18:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:18:12 INFO - 'SHELL': '/bin/bash', 11:18:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9h6eWAtNF2/Listeners', 11:18:12 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 11:18:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:18:12 INFO - 'USER': 'cltbld', 11:18:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:18:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:18:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:12 INFO - 'XPC_FLAGS': '0x0', 11:18:12 INFO - 'XPC_SERVICE_NAME': '0', 11:18:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:18:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:12 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 11:18:12 INFO - Cleaning up... 11:18:12 INFO - Return code: 0 11:18:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:18:12 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')]} 11:18:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:12 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')]} 11:18:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:12 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 0x106efcb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106eff768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8322cb5190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cdad30>, '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 0x106c01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ccfbe8>, '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.YFy4gx0Kd1/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.9h6eWAtNF2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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 11:18:12 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 11:18:12 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 11:18:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YFy4gx0Kd1/Render', 11:18:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:18:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:18:12 INFO - 'HOME': '/Users/cltbld', 11:18:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:18:12 INFO - 'LOGNAME': 'cltbld', 11:18:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:12 INFO - 'MOZ_NO_REMOTE': '1', 11:18:12 INFO - 'NO_EM_RESTART': '1', 11:18:12 INFO - 'PAGER': '/bin/cat', 11:18:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:18:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:12 INFO - 'PWD': '/builds/slave/test', 11:18:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:18:12 INFO - 'SHELL': '/bin/bash', 11:18:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9h6eWAtNF2/Listeners', 11:18:12 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 11:18:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:18:12 INFO - 'USER': 'cltbld', 11:18:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:18:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:18:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:12 INFO - 'XPC_FLAGS': '0x0', 11:18:12 INFO - 'XPC_SERVICE_NAME': '0', 11:18:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:18:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:12 INFO - Downloading/unpacking psutil>=3.1.1 11:18: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 11:18: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 11:18: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 11:18: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 11:18: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 11:18: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 11:18:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:18:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:18:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:18:16 INFO - Installing collected packages: psutil 11:18:16 INFO - Running setup.py install for psutil 11:18:16 INFO - building 'psutil._psutil_osx' extension 11:18:16 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 11:18:16 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 11:18:17 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 11:18:17 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 11:18:17 INFO - building 'psutil._psutil_posix' extension 11:18:17 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 11:18:17 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:18:17 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:18:17 INFO - ^ 11:18:17 INFO - 1 warning generated. 11:18:17 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 11:18:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:18:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:18:17 INFO - Successfully installed psutil 11:18:17 INFO - Cleaning up... 11:18:17 INFO - Return code: 0 11:18:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:18:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:18:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:18:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106efcb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106eff768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8322cb5190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cdad30>, '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 0x106c01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ccfbe8>, '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.YFy4gx0Kd1/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.9h6eWAtNF2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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 11:18:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:18:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:18:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YFy4gx0Kd1/Render', 11:18:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:18:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:18:18 INFO - 'HOME': '/Users/cltbld', 11:18:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:18:18 INFO - 'LOGNAME': 'cltbld', 11:18:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:18 INFO - 'MOZ_NO_REMOTE': '1', 11:18:18 INFO - 'NO_EM_RESTART': '1', 11:18:18 INFO - 'PAGER': '/bin/cat', 11:18:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:18:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:18 INFO - 'PWD': '/builds/slave/test', 11:18:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:18:18 INFO - 'SHELL': '/bin/bash', 11:18:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9h6eWAtNF2/Listeners', 11:18:18 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 11:18:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:18:18 INFO - 'USER': 'cltbld', 11:18:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:18:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:18:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:18 INFO - 'XPC_FLAGS': '0x0', 11:18:18 INFO - 'XPC_SERVICE_NAME': '0', 11:18:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:18:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:18:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:18:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:18:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:18:21 INFO - Installing collected packages: mozsystemmonitor 11:18:21 INFO - Running setup.py install for mozsystemmonitor 11:18:21 INFO - Successfully installed mozsystemmonitor 11:18:21 INFO - Cleaning up... 11:18:21 INFO - Return code: 0 11:18:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:18:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:18:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:18:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x106efcb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106eff768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8322cb5190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cdad30>, '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 0x106c01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ccfbe8>, '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.YFy4gx0Kd1/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.9h6eWAtNF2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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 11:18:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:18:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:18:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YFy4gx0Kd1/Render', 11:18:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:18:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:18:21 INFO - 'HOME': '/Users/cltbld', 11:18:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:18:21 INFO - 'LOGNAME': 'cltbld', 11:18:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:21 INFO - 'MOZ_NO_REMOTE': '1', 11:18:21 INFO - 'NO_EM_RESTART': '1', 11:18:21 INFO - 'PAGER': '/bin/cat', 11:18:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:18:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:21 INFO - 'PWD': '/builds/slave/test', 11:18:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:18:21 INFO - 'SHELL': '/bin/bash', 11:18:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9h6eWAtNF2/Listeners', 11:18:21 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 11:18:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:18:21 INFO - 'USER': 'cltbld', 11:18:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:18:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:18:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:21 INFO - 'XPC_FLAGS': '0x0', 11:18:21 INFO - 'XPC_SERVICE_NAME': '0', 11:18:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:18:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:22 INFO - Downloading/unpacking jsonschema==2.5.1 11:18:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:18:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:18:24 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 11:18:24 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 11:18:24 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 11:18:24 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 11:18:24 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 11:18:24 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 11:18:25 INFO - Downloading functools32-3.2.3-2.tar.gz 11:18:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:18:25 INFO - warning: no files found matching '*.txt' 11:18:25 INFO - no previously-included directories found matching 'build' 11:18:25 INFO - no previously-included directories found matching 'dist' 11:18:25 INFO - no previously-included directories found matching '.git*' 11:18:25 INFO - Installing collected packages: jsonschema, functools32 11:18:25 INFO - Running setup.py install for functools32 11:18:25 INFO - warning: no files found matching '*.txt' 11:18:25 INFO - no previously-included directories found matching 'build' 11:18:25 INFO - no previously-included directories found matching 'dist' 11:18:25 INFO - no previously-included directories found matching '.git*' 11:18:25 INFO - Successfully installed jsonschema functools32 11:18:25 INFO - Cleaning up... 11:18:25 INFO - Return code: 0 11:18:25 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:18:25 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')]} 11:18:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:25 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')]} 11:18:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:25 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 0x106efcb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106eff768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8322cb5190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cdad30>, '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 0x106c01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ccfbe8>, '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.YFy4gx0Kd1/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.9h6eWAtNF2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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 11:18:25 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 11:18:25 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 11:18:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YFy4gx0Kd1/Render', 11:18:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:18:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:18:25 INFO - 'HOME': '/Users/cltbld', 11:18:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:18:25 INFO - 'LOGNAME': 'cltbld', 11:18:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:25 INFO - 'MOZ_NO_REMOTE': '1', 11:18:25 INFO - 'NO_EM_RESTART': '1', 11:18:25 INFO - 'PAGER': '/bin/cat', 11:18:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:18:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:25 INFO - 'PWD': '/builds/slave/test', 11:18:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:18:25 INFO - 'SHELL': '/bin/bash', 11:18:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9h6eWAtNF2/Listeners', 11:18:25 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 11:18:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:18:25 INFO - 'USER': 'cltbld', 11:18:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:18:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:18:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:25 INFO - 'XPC_FLAGS': '0x0', 11:18:25 INFO - 'XPC_SERVICE_NAME': '0', 11:18:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:18:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:25 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:18:25 INFO - Cleaning up... 11:18:25 INFO - Return code: 0 11:18:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:18:25 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')]} 11:18:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:25 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')]} 11:18:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:25 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 0x106efcb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106eff768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8322cb5190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cdad30>, '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 0x106c01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ccfbe8>, '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.YFy4gx0Kd1/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.9h6eWAtNF2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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 11:18:25 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 11:18:25 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 11:18:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YFy4gx0Kd1/Render', 11:18:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:18:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:18:25 INFO - 'HOME': '/Users/cltbld', 11:18:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:18:25 INFO - 'LOGNAME': 'cltbld', 11:18:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:25 INFO - 'MOZ_NO_REMOTE': '1', 11:18:25 INFO - 'NO_EM_RESTART': '1', 11:18:25 INFO - 'PAGER': '/bin/cat', 11:18:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:18:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:25 INFO - 'PWD': '/builds/slave/test', 11:18:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:18:25 INFO - 'SHELL': '/bin/bash', 11:18:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9h6eWAtNF2/Listeners', 11:18:25 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 11:18:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:18:25 INFO - 'USER': 'cltbld', 11:18:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:18:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:18:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:25 INFO - 'XPC_FLAGS': '0x0', 11:18:25 INFO - 'XPC_SERVICE_NAME': '0', 11:18:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:18:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:26 INFO - Downloading/unpacking blobuploader==1.2.4 11:18: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 11:18: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 11:18: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 11:18: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 11:18: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 11:18: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 11:18:28 INFO - Downloading blobuploader-1.2.4.tar.gz 11:18:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:18:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:18:28 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 11:18:28 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 11:18:28 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 11:18:28 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 11:18:28 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 11:18:28 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 11:18:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:18:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:18:29 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 11:18:29 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 11:18:29 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 11:18:29 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 11:18:29 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 11:18:29 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 11:18:29 INFO - Downloading docopt-0.6.1.tar.gz 11:18:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:18:30 INFO - Installing collected packages: blobuploader, requests, docopt 11:18:30 INFO - Running setup.py install for blobuploader 11:18:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:18:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:18:30 INFO - Running setup.py install for requests 11:18:30 INFO - Running setup.py install for docopt 11:18:30 INFO - Successfully installed blobuploader requests docopt 11:18:30 INFO - Cleaning up... 11:18:30 INFO - Return code: 0 11:18:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:18:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:18:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:18:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:30 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 0x106efcb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106eff768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8322cb5190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cdad30>, '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 0x106c01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ccfbe8>, '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.YFy4gx0Kd1/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.9h6eWAtNF2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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 11:18:30 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 11:18:30 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 11:18:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YFy4gx0Kd1/Render', 11:18:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:18:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:18:30 INFO - 'HOME': '/Users/cltbld', 11:18:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:18:30 INFO - 'LOGNAME': 'cltbld', 11:18:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:30 INFO - 'MOZ_NO_REMOTE': '1', 11:18:30 INFO - 'NO_EM_RESTART': '1', 11:18:30 INFO - 'PAGER': '/bin/cat', 11:18:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:18:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:30 INFO - 'PWD': '/builds/slave/test', 11:18:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:18:30 INFO - 'SHELL': '/bin/bash', 11:18:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9h6eWAtNF2/Listeners', 11:18:30 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 11:18:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:18:30 INFO - 'USER': 'cltbld', 11:18:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:18:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:18:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:30 INFO - 'XPC_FLAGS': '0x0', 11:18:30 INFO - 'XPC_SERVICE_NAME': '0', 11:18:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:18:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:18:31 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-TDPGsU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:18:31 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-juhQHy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:18:31 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-zcwKAe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:18:31 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-TZbphI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:18:31 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-IAWO_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:18:31 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-JYUGbf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:18:31 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-FfUMd_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:18:31 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-v6gnlH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:18:32 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-b9GEVh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:18:32 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-UdwS77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:18:32 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-7bCmzt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:18:32 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-Apdr3z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:18:32 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-KeIKqB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:18:32 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-nOxfcu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:18:32 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-7eTiRD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:18:32 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-amChZ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:18:32 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-AVzI7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:18:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:18:32 INFO - Running setup.py install for manifestparser 11:18:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:18:33 INFO - Running setup.py install for mozcrash 11:18:33 INFO - Running setup.py install for mozdebug 11:18:33 INFO - Running setup.py install for mozdevice 11:18:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:18:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:18:33 INFO - Running setup.py install for mozfile 11:18:33 INFO - Running setup.py install for mozhttpd 11:18:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:18:33 INFO - Running setup.py install for mozinfo 11:18:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:18:33 INFO - Running setup.py install for mozInstall 11:18:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:18:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:18:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:18:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:18:34 INFO - Running setup.py install for mozleak 11:18:34 INFO - Running setup.py install for mozlog 11:18:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:18:34 INFO - Running setup.py install for moznetwork 11:18:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:18:34 INFO - Running setup.py install for mozprocess 11:18:34 INFO - Running setup.py install for mozprofile 11:18:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:18:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:18:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:18:34 INFO - Running setup.py install for mozrunner 11:18:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:18:35 INFO - Running setup.py install for mozscreenshot 11:18:35 INFO - Running setup.py install for moztest 11:18:35 INFO - Running setup.py install for mozversion 11:18:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:18:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:18:35 INFO - Cleaning up... 11:18:35 INFO - Return code: 0 11:18:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:18:35 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')]} 11:18:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:35 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')]} 11:18:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:35 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 0x106efcb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106eff768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8322cb5190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cdad30>, '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 0x106c01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ccfbe8>, '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.YFy4gx0Kd1/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.9h6eWAtNF2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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 11:18:35 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 11:18:35 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 11:18:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YFy4gx0Kd1/Render', 11:18:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:18:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:18:35 INFO - 'HOME': '/Users/cltbld', 11:18:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:18:35 INFO - 'LOGNAME': 'cltbld', 11:18:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:35 INFO - 'MOZ_NO_REMOTE': '1', 11:18:35 INFO - 'NO_EM_RESTART': '1', 11:18:35 INFO - 'PAGER': '/bin/cat', 11:18:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:18:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:35 INFO - 'PWD': '/builds/slave/test', 11:18:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:18:35 INFO - 'SHELL': '/bin/bash', 11:18:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9h6eWAtNF2/Listeners', 11:18:35 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 11:18:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:18:35 INFO - 'USER': 'cltbld', 11:18:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:18:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:18:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:35 INFO - 'XPC_FLAGS': '0x0', 11:18:35 INFO - 'XPC_SERVICE_NAME': '0', 11:18:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:18:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:18:35 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-YLe9TG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:18:35 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)) 11:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:18:35 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-ru02NB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:18:36 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)) 11:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:18:36 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-26yu3a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:18:36 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)) 11:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:18:36 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-xYRxXh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:18:36 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)) 11:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:18:36 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-hhcqDm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:18:36 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)) 11:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:18:36 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-CMzTU2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:18:36 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)) 11:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:18:36 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-EDrYti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:18:36 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)) 11:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:18:36 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-FfKlnK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:18:36 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)) 11:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:18:36 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-qSmAHS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:18:36 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)) 11:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:18:36 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-uP6tQm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:18:36 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)) 11:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:18:36 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-WXxFPX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:18:36 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)) 11:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:18:36 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-PSr0st-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:18:37 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)) 11:18:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:18:37 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-6t2OWX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:18:37 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)) 11:18:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:18:37 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-WdO384-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:18:37 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)) 11:18:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:18:37 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-Msfb4f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:18:37 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)) 11:18:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:18:37 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-bdkZLP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:18:37 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)) 11:18:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:18:37 INFO - Running setup.py (path:/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/pip-6SAkoX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:18:37 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)) 11:18:37 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)) 11:18:37 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)) 11:18:37 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)) 11:18:37 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)) 11:18:37 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)) 11:18:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:18:37 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 11:18:37 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 11:18:37 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 11:18:37 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 11:18:37 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 11:18:37 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 11:18:40 INFO - Downloading blessings-1.6.tar.gz 11:18:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:18:40 INFO - Installing collected packages: blessings 11:18:40 INFO - Running setup.py install for blessings 11:18:40 INFO - Successfully installed blessings 11:18:40 INFO - Cleaning up... 11:18:40 INFO - Return code: 0 11:18:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:18:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:18:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:18:40 INFO - Reading from file tmpfile_stdout 11:18:40 INFO - Current package versions: 11:18:40 INFO - blessings == 1.6 11:18:40 INFO - blobuploader == 1.2.4 11:18:40 INFO - docopt == 0.6.1 11:18:40 INFO - functools32 == 3.2.3-2 11:18:40 INFO - jsonschema == 2.5.1 11:18:40 INFO - manifestparser == 1.1 11:18:40 INFO - mozInstall == 1.12 11:18:40 INFO - mozcrash == 1.0 11:18:40 INFO - mozdebug == 0.1 11:18:40 INFO - mozdevice == 0.49 11:18:40 INFO - mozfile == 1.2 11:18:40 INFO - mozhttpd == 0.7 11:18:40 INFO - mozinfo == 0.9 11:18:40 INFO - mozleak == 0.1 11:18:40 INFO - mozlog == 3.4 11:18:40 INFO - moznetwork == 0.27 11:18:40 INFO - mozprocess == 0.25 11:18:40 INFO - mozprofile == 0.28 11:18:40 INFO - mozrunner == 6.13 11:18:40 INFO - mozscreenshot == 0.1 11:18:40 INFO - mozsystemmonitor == 0.3 11:18:40 INFO - moztest == 0.8 11:18:40 INFO - mozversion == 1.4 11:18:40 INFO - psutil == 3.1.1 11:18:40 INFO - requests == 1.2.3 11:18:40 INFO - wsgiref == 0.1.2 11:18:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:18:40 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')]} 11:18:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:40 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')]} 11:18:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:40 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 0x106efcb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106eff768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8322cb5190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cdad30>, '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 0x106c01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ccfbe8>, '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.YFy4gx0Kd1/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.9h6eWAtNF2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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 11:18:40 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 11:18:40 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 11:18:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YFy4gx0Kd1/Render', 11:18:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:18:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:18:40 INFO - 'HOME': '/Users/cltbld', 11:18:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:18:40 INFO - 'LOGNAME': 'cltbld', 11:18:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:40 INFO - 'MOZ_NO_REMOTE': '1', 11:18:40 INFO - 'NO_EM_RESTART': '1', 11:18:40 INFO - 'PAGER': '/bin/cat', 11:18:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:18:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:40 INFO - 'PWD': '/builds/slave/test', 11:18:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:18:40 INFO - 'SHELL': '/bin/bash', 11:18:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9h6eWAtNF2/Listeners', 11:18:40 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 11:18:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:18:40 INFO - 'USER': 'cltbld', 11:18:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:18:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:18:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:40 INFO - 'XPC_FLAGS': '0x0', 11:18:40 INFO - 'XPC_SERVICE_NAME': '0', 11:18:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:18:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:41 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)) 11:18:41 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)) 11:18:41 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)) 11:18:41 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)) 11:18:41 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)) 11:18:41 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)) 11:18:41 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)) 11:18:41 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)) 11:18:41 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)) 11:18:41 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)) 11:18:41 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)) 11:18:41 INFO - Cleaning up... 11:18:41 INFO - Return code: 0 11:18:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:18:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:18:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:18:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:41 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 0x106efcb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106eff768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8322cb5190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cdad30>, '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 0x106c01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ccfbe8>, '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.YFy4gx0Kd1/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.9h6eWAtNF2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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 11:18:41 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 11:18:41 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 11:18:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YFy4gx0Kd1/Render', 11:18:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:18:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:18:41 INFO - 'HOME': '/Users/cltbld', 11:18:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:18:41 INFO - 'LOGNAME': 'cltbld', 11:18:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:41 INFO - 'MOZ_NO_REMOTE': '1', 11:18:41 INFO - 'NO_EM_RESTART': '1', 11:18:41 INFO - 'PAGER': '/bin/cat', 11:18:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:18:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:41 INFO - 'PWD': '/builds/slave/test', 11:18:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:18:41 INFO - 'SHELL': '/bin/bash', 11:18:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9h6eWAtNF2/Listeners', 11:18:41 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 11:18:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:18:41 INFO - 'USER': 'cltbld', 11:18:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:18:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:18:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:41 INFO - 'XPC_FLAGS': '0x0', 11:18:41 INFO - 'XPC_SERVICE_NAME': '0', 11:18:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:18:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:18:41 INFO - Cleaning up... 11:18:41 INFO - Return code: 0 11:18:41 INFO - Running post-action listener: _resource_record_post_action 11:18:41 INFO - Running post-action listener: _start_resource_monitoring 11:18:41 INFO - Starting resource monitoring. 11:18:41 INFO - [mozharness: 2017-03-21 18:18:41.385839Z] Finished create-virtualenv step (success) 11:18:41 INFO - [mozharness: 2017-03-21 18:18:41.386849Z] Running install step. 11:18:41 INFO - Running pre-action listener: _resource_record_pre_action 11:18:41 INFO - Running main action method: install 11:18:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:18:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:18:41 INFO - Reading from file tmpfile_stdout 11:18:41 INFO - Detecting whether we're running mozinstall >=1.0... 11:18:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:18:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:18:41 INFO - Reading from file tmpfile_stdout 11:18:41 INFO - Output received: 11:18:41 INFO - Usage: mozinstall [options] installer 11:18:41 INFO - Options: 11:18:41 INFO - -h, --help show this help message and exit 11:18:41 INFO - -d DEST, --destination=DEST 11:18:41 INFO - Directory to install application into. [default: 11:18:41 INFO - "/builds/slave/test"] 11:18:41 INFO - --app=APP Application being installed. [default: firefox] 11:18:41 INFO - mkdir: /builds/slave/test/build/application 11:18:41 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'] 11:18:41 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 11:19:01 INFO - Reading from file tmpfile_stdout 11:19:01 INFO - Output received: 11:19:01 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 11:19:01 INFO - Running post-action listener: _resource_record_post_action 11:19:01 INFO - [mozharness: 2017-03-21 18:19:01.880639Z] Finished install step (success) 11:19:01 INFO - [mozharness: 2017-03-21 18:19:01.880783Z] Running run-tests step. 11:19:01 INFO - Running pre-action listener: _resource_record_pre_action 11:19:01 INFO - Running main action method: run_tests 11:19:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:19:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:19:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:19:01 INFO - 2017-03-21 11:19:01.895 screenresolution[1637:7432] starting screenresolution argv=screenresolution get 11:19:01 INFO - 2017-03-21 11:19:01.898 screenresolution[1637:7432] Display 0: 1600x1200x32@60 11:19:01 INFO - 2017-03-21 11:19:01.903 screenresolution[1638:7434] starting screenresolution argv=screenresolution list 11:19:01 INFO - Available Modes on Display 0 11:19:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:19:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:19:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:19:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:19:02 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:19:02 INFO - Intel Iris: 11:19:02 INFO - Chipset Model: Intel Iris 11:19:02 INFO - Type: GPU 11:19:02 INFO - Bus: Built-In 11:19:02 INFO - VRAM (Dynamic, Max): 1536 MB 11:19:02 INFO - Vendor: Intel (0x8086) 11:19:02 INFO - Device ID: 0x0a2e 11:19:02 INFO - Revision ID: 0x0009 11:19:02 INFO - Displays: 11:19:02 INFO - Display: 11:19:02 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:19:02 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:19:02 INFO - Display Serial Number: 1600x1200 60 11:19:02 INFO - Main Display: Yes 11:19:02 INFO - Mirror: Off 11:19:02 INFO - Online: Yes 11:19:02 INFO - Rotation: Supported 11:19:02 INFO - Return code: 0 11:19:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:19:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:19:02 INFO - Python 2.7.3 11:19:02 INFO - Return code: 0 11:19:02 INFO - grabbing minidump binary from tooltool 11:19:02 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')]} 11:19:02 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 0x106cdad30>, '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 0x106c01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ccfbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:19:02 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 11:19:02 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 11:19:02 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 11:19:02 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:19:02 INFO - Return code: 0 11:19:02 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:19:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:19:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:19:02 INFO - ENV: RUST_BACKTRACE is now 1 11:19:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:19:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:19:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DpJ_0uuqQfyqN9k8ZTvquw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0181', '--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 11:19:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DpJ_0uuqQfyqN9k8ZTvquw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0181 --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 11:19:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YFy4gx0Kd1/Render', 11:19:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:19:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:19:02 INFO - 'HOME': '/Users/cltbld', 11:19:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:19:02 INFO - 'LOGNAME': 'cltbld', 11:19:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:19:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:19:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:02 INFO - 'MOZ_NO_REMOTE': '1', 11:19:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:19:02 INFO - 'NO_EM_RESTART': '1', 11:19:02 INFO - 'PAGER': '/bin/cat', 11:19:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:19:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:19:02 INFO - 'PWD': '/builds/slave/test', 11:19:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:19:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:19:02 INFO - 'RUST_BACKTRACE': '1', 11:19:02 INFO - 'SHELL': '/bin/bash', 11:19:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9h6eWAtNF2/Listeners', 11:19:02 INFO - 'TMPDIR': '/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/', 11:19:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:19:02 INFO - 'USER': 'cltbld', 11:19:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:19:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:19:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:02 INFO - 'XPC_FLAGS': '0x0', 11:19:02 INFO - 'XPC_SERVICE_NAME': '0', 11:19:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:19:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DpJ_0uuqQfyqN9k8ZTvquw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0181', '--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 11:19:02 INFO - mozversion application_buildid: 20170321092323 11:19:02 INFO - mozversion application_changeset: 9fb5e850ab7ab0b2b90640c604f66038407b411d 11:19:02 INFO - mozversion application_display_name: Nightly 11:19:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:19:02 INFO - mozversion application_name: Firefox 11:19:02 INFO - mozversion application_remotingname: firefox 11:19:02 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:19:02 INFO - mozversion application_vendor: Mozilla 11:19:02 INFO - mozversion application_version: 55.0a1 11:19:02 INFO - mozversion platform_buildid: 20170321092323 11:19:02 INFO - mozversion platform_changeset: 9fb5e850ab7ab0b2b90640c604f66038407b411d 11:19:02 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:19:02 INFO - mozversion platform_version: 55.0a1 11:19:02 INFO - using testdate: 1490120342 11:19:02 INFO - actual date: 1490120342 11:19:02 INFO - starting webserver on 'localhost:49236' 11:19:02 INFO - SUITE-START | Running 2 tests 11:19:02 INFO - TEST-START | dromaeo_css 11:19:02 INFO - operating with platform_type : mac_ 11:19:02 INFO - Initialising browser for dromaeo_css test... 11:19:02 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/tmp7OMlIQ/profile http://localhost:49236/getInfo.html) 11:19:05 INFO - PID 1648 | 2017-03-21 11:19:05.360 plugin-container[1650:7618] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f3f, name = 'com.apple.tsm.portname' 11:19:05 INFO - PID 1648 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:19:05 INFO - PID 1648 | 2017-03-21 11:19:05.362 plugin-container[1650:7618] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x950b, name = 'com.apple.CFPasteboardClient' 11:19:05 INFO - PID 1648 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:19:05 INFO - PID 1648 | 2017-03-21 11:19:05.363 plugin-container[1650:7618] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:19:05 INFO - PID 1648 | __metrics Screen width/height:1600/1200 11:19:05 INFO - PID 1648 | colorDepth:24 11:19:05 INFO - PID 1648 | Browser inner width/height: 1024/689 11:19:05 INFO - PID 1648 | __metrics 11:19:05 ERROR - PID 1648 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3350: TypeError: this.tabs is undefined 11:19:06 INFO - TEST-INFO | 1648: exit 0 11:19:06 INFO - Browser initialized. 11:19:06 INFO - Running cycle 1/1 for dromaeo_css test... 11:19:06 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/tmp7OMlIQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:19:09 INFO - PID 1651 | 2017-03-21 11:19:09.029 plugin-container[1652:7734] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c3f, name = 'com.apple.tsm.portname' 11:19:09 INFO - PID 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:19:09 INFO - PID 1651 | 2017-03-21 11:19:09.029 plugin-container[1652:7734] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4813, name = 'com.apple.CFPasteboardClient' 11:19:09 INFO - PID 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:19:09 INFO - PID 1651 | 2017-03-21 11:19:09.029 plugin-container[1652:7734] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:19:18 INFO - PID 1651 | RSS: Main: 226611200 11:19:18 INFO - PID 1651 | 11:22:22 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49236/tests/dromaeo/cssquery-ext.html) 11:22:24 INFO - PID 1651 | RSS: Main: 250707968 11:22:24 INFO - PID 1651 | 11:24:06 INFO - PID 1651 | ************************* 11:24:06 INFO - PID 1651 | A coding exception was thrown and uncaught in a Task. 11:24:06 INFO - PID 1651 | 11:24:06 ERROR - PID 1651 | Full message: TypeError: NetworkError when attempting to fetch resource. 11:24:06 INFO - PID 1651 | Full stack: 11:24:06 INFO - PID 1651 | ************************* 11:25:26 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-ext.html (next: http://localhost:49236/tests/dromaeo/cssquery-jquery.html) 11:25:27 INFO - PID 1651 | RSS: Main: 261844992 11:25:27 INFO - PID 1651 | 11:28:29 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49236/tests/dromaeo/cssquery-mootools.html) 11:28:29 INFO - PID 1651 | RSS: Main: 272961536 11:28:29 INFO - PID 1651 | 11:31:31 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49236/tests/dromaeo/cssquery-prototype.html) 11:31:32 INFO - PID 1651 | RSS: Main: 265289728 11:31:32 INFO - PID 1651 | 11:34:35 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49236/tests/dromaeo/cssquery-yui.html) 11:34:35 INFO - PID 1651 | RSS: Main: 275542016 11:34:35 INFO - PID 1651 | 11:37:38 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-yui.html (next: http://localhost:49236/tests/dromaeo/cssquery-dojo.html) 11:37:38 INFO - PID 1651 | RSS: Main: 269316096 11:37:38 INFO - PID 1651 | 11:37:38 INFO - PID 1651 | __start_tp_report 11:37:38 INFO - PID 1651 | _x_x_mozilla_page_load 11:37:38 INFO - PID 1651 | _x_x_mozilla_page_load_details 11:37:38 INFO - PID 1651 | |i|pagename|runs| 11:37:38 INFO - PID 1651 | |0;dojo.html;3517.366873962687;3542.592601850788;3548.414511605585;3578.695810856077;3585.157487990322;5113.897722045562;6127.050307202385;6141.986572215579;6219.751209951596;6288.119663247149;6110.892920173598;6198.845028874281;6226;6275.497960163188;6301.527385446098;5571.0807716726695;5580.162975553659;5736.512396446307;5762.4525670061485;5813;4574.313852922055;4623.9768801156115;5045.318881950926;5523.1163013917785;5771.971140144294;4762.761861906891;5311.707856067915;5526.143447765603;5568.832935011957;5627.803026894059;4727.818045488628;5345.224942383372;5533.667979921218;5569.749361278712;5590.161475778625;5454.945450545483;5462.562994960394;5474.562035037187;5553.555715542747;5633.126865335838;4698.671093023489;5438.075527160392;6213.782517611907;6264.248290205159;6273.1531243282025;6621.337866213388;6646.335366463363;6656.633885136315;6674.432673222782;6675.098861653663;6432.678366081724;6462.547621666486;6559.868802623921;6597.93402065978;6667.433268172211;5201.115810312181;5478;5723.02708539541;5900.822975310747;6370.681465926731;6853.314668533107;6859.17689877208;6906.516543841984;6914.757983470555;6921.307869213139;6348.396902294275;6509.349065093547;6510.21877374718;6518.608883467007;6571.31001244872;6670.032845237413;6683.6324002180345;6691.26396096429;6700.597964122168;6717.865642687118;6570.211574611078;6589.703463344065;6597.1423714916755;6601.174853143357;6604.976228684562;6310.5898116622275;6408.070829729663;6429.839254018687;6553.377429144223;6559.8032059038305;5318.282031925641;5344.038073146871;5350.8662283442445;5370.006548788487;5370.221317908881;4676.69601475903;4726.196546587088;4740.620750339965;4749.596284315872;4751.881202969884;5216.347956505437;6236.781712640036;6284.780032698834;6294.716737746812;6318.336574659686;6718.7312507499155;6767.864642707118;6800.387965083166;6808.863822723518;6829.6243706596615;5201.739913004335;6234.1583886175695;6319.0837328587095;6336.049592561153;6354.428101470798;4702.882427939329;5775.451332123442;5889.087191485327;5891.7054147292465;5915.260592425947;6739.258681544928;6919.515633905578;6962.860742785218;6980.7905762827195;7002.1947476040905;6757.493188011017;6780.660966951534;6780.796576102724;6782.152230971129;6785.287544807724;6430.7749228776765;6452.096706461005;6469.902951455826;6892.448604111759;6901.75843845463;5536.2249285100925;5910.438508341701;6660.700268487833;6664.333566643297;6672.032555279555;5283.471652834686;5451.563874890078;6352.792969335811;6369.87260254783;6673.399394054559;6340.9048864268;6443.484521238383;6446.871062578816;6453.51598630114;6453.774117905851;6443.96778016107;6450.096986421999;6450.258220304725;6458.903116453163;6459.257185423737;5261.842144735664;6041.607295525777;6259.2488901332135;6327.557071004985;6340.904886426615;6423.454006409321;6478.352164783484;6498.3826536478955;6505.024246363083;6507.511936604679;6299.527535434952;6358.300586935341;6369.235691717024;6379.808605741835;6403.359664033559 11:37:38 INFO - PID 1651 | |1;ext.html;679.6703598754603;724.9710011599536;728.2899173306027;790.537535541708;793.773774474275;36463.08842278944;36894;37036.88889333318;37070.8146459268;37442.81278593607;36072.27855442896;36542.08644783882;36565.634343656624;36690.082747931316;36882.262354752886;2464.8151388645924;2523.205190365029;2668.8799004044818;2826.8162569433025;2899.246195989037;2464.8397854139425;2821.4216085702483;2891.927701807451;2893.0597555794347;2894.898678546251;2872.971270287291;2882.8126171798767;2883.927901802451;2898.116074597247;2899.3186601148714;2857.171420288135;2870.038537090077;2886.408286301303;2897.029495119127;2904.8111872728205;2863.6706778720504;2868.9815115634065;2887.7112288771164;2892.942141157186;2901.0571564241704;36911.63088369136;37235;37317.62682373168;38434.42348364777;38574.22851542953;3018.77359198061;3032.848357582134;3036.6052413186144;3041.8022828516296;3067.4631939410515;27023.729762702515;27350.589741153897;27512.312192195153;27691.584626230622;28333.433331333465;2811.2550174203852;2825.6609206895305;2832.4335132973283;2848.1313199474152;2867.1828528869173;241186;316557;321389;323859;325376.9999999976;37535.81232093822;38253.42619860704;45781;46691.766541167075;46789.830254243236;48610.27084593734;49032.50967490351;49105.75447122742;49142.75428622834;49186.50813491819;13879.028468007344;13925.930370348084;14062.22657753813;14081.647958801112;14082.295885205698;11389.430528473544;11411.42942852854;11412;11569.363684997237;11766.352850593299;12451.25292482454;12457.813132803016;12459.501619935101;12532.749345013232;12562.560310389092;5442.401335853053;5446.972765136228;5452.836414907559;5463.098588732814;5485.61600687948;876.6756300168978;904.3895370624801;916.4134953629682;968.1238479176357;972.6401231544232;20808.79191208099;21503.2473863414;23603.645945310833;23842.761572384403;24180.395490112536;1040.484959944832;1042.166266986408;1042.838360054193;1078.8112080385902;1079.3501952706088;11657.941710291394;12201.45093470796;12219.144659873724;12229.816552751716;12253.69365765863;413665;415924;416410;417228;418072;54252;54334.18498722522;54335.45664543304;54403.72798135984;54432;1178.6169494914186;1415.0731271017294;1463.2610531681432;1465.4211586423517;1469.8971072024856;22793.088276469418;23271.185508507122;23399.76600233976;23486.64770028485;23594.882025589763;37178;37253.81373093117;37260.44109338308;37271;37404.62595374011;405779;406913;407433;408978;410707;32654.51018234776;33257.334853303284;33277.50083748794;33431.83284083564;33481.16297092495;42008.78995605002;42130.578694212665;43485.69542913717;43577.69266921998;43712.78143609261;35097.64902350944;35224.647753522135;35294.64705353016;36244;36320.81839590785;34505.654943450245;34799.95600132;35558;35773.10567235736;35828.82085589555;34546.82726586351;34872.47691284582;35836;35984.10039749027;35989.28021439609;30365.544516831822;31559;31706.04881853548;31737.715408420492;32390.514142287415;19145.425637230906;23352.76647233506;24051.51896962016;24187.879060604584;24241.151559695325 11:37:38 INFO - PID 1651 | |2;jquery.html;404.06257482640285;414.7055590530723;414.70763112006057;422.1514755341763;436.12339198211583;19190.040497975097;20642.17431302748;21141.942902854873;21412.89293553532;21979.780202197973;22085.33743987679;22552.21067262646;22763.772362276373;23564.11192153297;23587.528249435;3819.6562309392148;4187.895302617444;4335.501417336999;4354.847580334689;4362.302031674933;3655.232401195752;4178.394132850734;4285.142971405716;4328.458942632171;4354.542773008836;4246.80889359978;4254.085371645096;4271.63691086258;4279.828806847722;4296.334068219416;4224.5353011168745;4259.020425302167;4263.275243208662;4269.018125831045;4283.01490657149;3823.8661646842506;3844.0582057395836;3877.5265399148143;3880.8641697540734;3919.7452165609143;21749.565008699894;26932.192034239004;27175.1847444577;27302.317442064108;27393.45213095727;1994.411648563677;2005.1979208316643;2021.2521367094268;2055.599158164159;2098.7691353951054;16057.598560036093;16441;16633.50099497017;16782.916085419616;17432.389866354744;1686.241191463834;1699.5808499902596;1715.2624371520242;1718.8367105124994;1735.9132043397778;124159.37920310431;145895;146421.2678936609;150005;151252;12272.447739851728;12302.81545776814;12386.442610082388;12456.75086498265;12552.497900084078;15913.522594322189;15947.760783588023;15948.165960914643;15955.601109972344;15982.200889955455;8822.75019869929;9004.63981440735;9042.18620324174;9076.183143517115;9173.44959302444;8682.218600325874;8690.391672582859;8692.78268043304;8814.427062241062;8815.691450799191;7080.114985626797;7552.811179720441;7868.173841746649;7984.081830589556;8044.718434854752;2186.147402513021;2190.408589680809;2195.813355864769;2202.41635966469;2526.9386857519885;836.6151570277618;883.8302610416924;938.6245501799335;947.1570302430843;977.5405559387077;17409.868358556654;18333.266669333345;20347.08438120288;20843.749375037547;20884.582308353747;888.2272422992038;968.6851773173606;979.4564016970508;989.8564708117283;1005.7586179316911;10639.98920102589;10850.945745271381;10962.068224200873;10965.232433729721;10971.396573188551;612379;725606;726077;735841;745015.9485646317;123754;160945;163962;164154.3584564163;165541;1142.5772464188303;1171.988280117205;1190.827330037157;1191.2733232728028;1192.9978817793096;17341.393051243147;17426.128693565017;18077.819221807615;18507.35224267144;18617;59728.70135649294;60719;61249.69375153274;61415;62429;85821;85837.57081214554;86954.56522717346;87726.5613671953;88277.55861220653;8508.74473765788;8532.146785321418;8642.178992995656;8752;8778;13832.792508112185;13838.792418113535;13862.306884655929;14181.645458863612;14298.928505357406;11673.241239319757;11855.70360740954;11872.525098995944;12027.037836973197;12099.092568057255;9822.705318840446;11261.71845703864;11701.88298117008;11857.466414011562;12099.697507562381;10352.585896564053;11236.775264494829;11747.647570572897;12097.75804483923;12185.756284874076;8404.915950840414;8692;8782.56087195625;11950.641480755592;12555.93722031384;9716.562754676197;11190.384528850991;11790.528378864748;11924.165308428326;12293.56972505958 11:37:38 INFO - PID 1651 | |3;mootools.html;1353;1396.3088271305705;1398.1680899864577;1408.5492642354445;1421.4598452588018;10177.542010609523;10348.016938390841;10539.262251642389;10574.99999999999;10596.523156457959;10402.323848949813;10511.421871797049;10561.841572376421;10580.941905809415;10609.78780424391;2374.631932050535;2393.808495320379;2415.2995631266913;2418.056957786465;2418.7581241875846;2342.8594284342907;2395.724491683461;2396.940076498084;2404.7955923746504;2412.2522018174336;2367.597508423572;2380.33350661815;2388.164142550111;2391.5934291170456;2407.181558270188;2272.4773302140434;2352.3060697094397;2354.081908055851;2360.3509035015422;2375.857448553075;2016.2842191022269;2098.192196004534;2310.7920287174065;2344.5662552427857;2405.1702162753822;10516.369017858953;10616;10650.988156125233;10814.972577605115;10846.240763146583;5992.370801065869;6207.34822843604;6220.502359811204;6233.438990490832;6236.03341482071;3858.4405261237243;3861.5366156061173;3909.8045097745285;3938.1532970411213;3966.484357033596;1103.624767579027;1117.6144230240554;1128.424503503211;1182.816663417163;1184.1296646964474;13260.602181934653;14384.784228236585;14488.565343039725;14616.780748288784;14624.853751462455;3920.4511368408444;4148.8133034013545;4370.737755734666;4858.7570621469495;5288.101022826128;10925;10947.83578246327;10958.342499450058;11008.889911100947;11081.612143574936;6092.847678808065;6102.877942441215;6104.603200791934;6112.938870611237;6116.785912493041;5435.374931882805;5487.5884308677005;5556.444355564492;5604.551635869121;5639.548836093103;4091.5098933643567;4174.186033723456;4221.303484925014;4246.532881383046;4253.468316460442;1240.6092080994638;1246.1463897230426;1248.875112488762;1257.7610254051701;1268.1883594499527;720.204174387305;722.8012296618472;749.7113611259705;751.1174370115093;788.4086934798901;4880.975595122001;5600.60795744294;6400.327965563642;6440.6135631862235;6460.127882735865;560.5431573267774;833.5748768128299;861.5175501718932;873.8951325840812;918.3112665500875;3480.269143479847;4038.0914294283552;4087;4186.727862688916;4200.369944508348;12759.405074365704;12973.027022973314;13091.607251782461;13095.083344165816;13109.475620975245;12971.481140754264;12976.416061277265;13008.674783130498;13027.804582931263;13035;9399.201067909167;9777.217822574177;9781.951090244504;9786.706398808046;9811.656592019244;5216.765245563883;6378.936210637834;6446.484281257582;6607.339266073354;6643.269240383651;11878.46546905374;12161;12171.208871423329;12250.877491224974;12270.202436841577;12030.518779249081;12123.211991220895;12202.938985305016;12251.69370765738;12261.264324140224;8404.789880253042;8648.567571621268;8792.47245165292;8842.24840888506;8851.513166775889;9773.951130244302;9934.304598678023;10018.048285412875;10018.549165287724;10041.196704263495;8455.661773529237;8686.652533898827;8766.824663506566;8791.868121978303;8867.68963086289;8533.53065581399;8544.615492302737;8579.65681372738;8660.523671198145;8675.652973881226;7474.92525074764;7559.5464272143845;7642.426817988562;7646.923530764621;7661.846763064819;4215.57844215576;5078.873028174326;5225.268462415189;5293.364796224324;5387.111126664056;5625.774969001194;5677.1768093627015;5683.8863222736145;5749.540036796962;5753.1945527627 11:37:38 INFO - PID 1651 | |4;prototype.html;379.50664136622385;380.518643915447;390.0307735277836;400.11774038245665;402.3903785764567;5971.940280597193;6093.847653808657;6212.689365531728;6298.362425769298;6344.555881088326;4283.635890949266;5593.664380137195;6132.773445310933;6157.199564056677;6196.008638617811;4833.637477189216;4835.298881662157;4842;4858.902821943559;4866.951330486685;3856.5179352580926;4244.957550424487;4701.3418121462855;4845.927311090337;4862.927056094161;4711.623070154396;4755.096531658991;4769.689970151929;4785.66500344976;4808;3941.6649584785328;4268.274393353137;4551.0215303709865;4812.398450193726;4831.685940413862;3727.8136093195503;3793.468914351993;4031.0325521874834;4228.830846766125;4237.915241695149;5976.46211840932;5992;5993.910091348634;6026.578139530235;6050.27396712393;5505.889882202334;5571.428571428572;5578;5615.522680572156;5628.718564071821;5582;6294.150289710876;6511.958086706104;6599.3070727573395;6600.194917160187;4699.7415142167165;4707.340972263886;4725.740084295362;4726.4328280606205;4736.478987311393;6690.933090669079;6873.965630171817;6948.548344357651;6983.511154219207;7015.4036906862975;4580.427446569179;4605.825514493783;4634.443866736014;4782.641301902302;4824.903501929942;4093;4886.413630364308;4900;4907.950940474123;4916.5820905222745;5357.383900851452;5475.534579560703;5497.862553436116;5530.5852061095575;5536.114221724505;6282.748690052438;6614.206295244601;6640.236372817091;6659.9001014984815;6666.83332916681;1476.3430273528177;1600.3678546974113;1600.5518454832666;1644.2436479219693;1668.8414600612923;1115.83820346051;1150.2638311480491;1155.5377848860355;1163.4008485629906;1168.9123315751353;5633.718314084279;5882.3529411764675;6179.783707570304;6193.225846769154;6240.4071613196675;5724.084146536534;6725.8654826903185;6791.320867913169;6805.584017673655;6819.601981593861;5986.850328741816;6081.908771368433;6132.356102609251;6156.168917196122;6200.007998720183;2864.3984763199546;3242.9351412972082;3519.6480351964597;3590.982045089758;3602.945955810665;5705.800296989669;6556.885329493997;6741.629210393377;7053.89419158713;7099.716011359487;5898.203742494708;6902.101921971498;6914.412274956584;6961.443084553223;6984.860302793915;5761.596688231867;6210.844728881814;6474.449671777952;6965.825854353681;7052.435805135577;5401.594880384066;6016.059481039926;6786.796396108125;6806.455483561204;6812.182538095461;5872.354041055566;5985.545926170249;6324.936750632435;6704.530682852153;6709.798706038827;5885.440883116097;6975.128108986377;6980.406665433495;7019.6490175492045;7030.226675065636;4600.930986035279;4828.348172996601;4840.201366774443;4847.733374664427;4859.31969524274;5281.630285879952;6148.815535533941;6484.870302594016;6632.933670663425;6792.218894827158;6084.60450070744;6116.360765344612;6330.132610879894;6481.578697384655;6596.340365963365;6181.9690901547;6563.3764792344655;6565.770198043046;6570.507211959027;6597.538172327891;5447.3735520414075;6371.74513019474;6391.360863913572;6392.20097487814;6422.197225346832;5765;6542.705578248895;6565.244996825235;6567.620799632131;6606.306337834651;5541.473560011793;6070.939290607214;6422.871542569216;6426.61440313564;6472.902906456501 11:37:38 INFO - PID 1651 | |5;yui.html;650.1190886348998;676.8849295619746;695.9408450281726;701.2356531380794;712.8360477090266;14970.775438368419;15448.845511544881;15605.84394156061;15791.447299344525;16007.199640017996;14718.63203419915;14733.92633036836;14751.557453276391;15023;15336.46322378717;922.0180507759248;942.6465075596651;947.1239103828965;949.4967667136428;949.6486300068984;944.3200895355333;949.103097572794;953.2469349214113;984.5421878826344;992.8907820139815;1023.2070145637116;1027.3835698580867;1033.503918119303;1034;1035.083950703625;1027.085893554737;1027.1525991057408;1027.594100330369;1029.2280789407944;1029.9957541397152;753.9924600754032;757.8673732096861;766.8044648614567;770.0297624992494;770.4067867741863;16149.434769783118;16313.184340783033;16431.26059327333;16722.66554668912;16945.66108677832;11189.608363707313;14727.779083313759;14920.70158596822;14969.775453368207;15171.62070948224;11480.598179063692;11663.533458661643;11668.299902005821;11865.644030679094;12408.379581021003;3005.2787331040613;3084.290613158986;3100.527409301574;3155.857986390618;3170.508571171472;110867;113458.29812552818;114262.42868785685;115254.16949966058;115738;10809.83785243222;11114.11087113029;11182.944085279685;11566.595169169039;11774.234674746114;23295.06819727226;23459.765402345758;23740.7625923742;23742.406439838796;23782.64326035111;7705.1524332324525;7783.104942931522;7850.921490785133;7897.921020789833;8074.434789564792;4001.9399709004388;4012.598740126022;4046.3323551614244;4051.47330846988;4072.3077076897;3987.52149742027;4096.549379568245;4300.78496075195;4487.41663583732;4516.277395616686;778.4395235430482;804.2801692485193;848.1687945813138;851.1275942159212;874.1651722604897;528.5507318779007;534.986625334362;536.9033573956647;558.7541481748099;578.3060327606888;9797.902020979842;10006.49967501622;10423.68728938133;10424.843627345595;10486.318389304823;536.246573564143;561.6882630140229;568.2584227582961;594.872102497965;595.7557401465378;4584.587387135174;4835.830745923876;4872.920231099251;4911.656184067152;4936.802527898915;88087;97826.53260201102;98090.01909980952;98325;99375;58934.11598826021;66272.33727662759;66316;87304;89195;66515;67091.66454167795;67339.66330168318;67977.66011169912;68610.3138968614;10135.949320253352;10610.469476526298;10636.468176591294;10679.252452328263;10703.946480267548;31304.686953130178;33945.660543395235;36346.63653363432;36799.63200367962;37368.25263494769;47920.56238312856;47963;48524.757376212896;48713.26930095981;48798.756006219744;13074.346282685638;13118.803217951929;13124.14693044949;13446.058775885986;13539.390727417092;12004.639860804189;14111.2944352784;14266.785998210244;14290.785638215642;14407.135571865721;13307.866921330662;13355.465781369025;13380.063395562218;13408.463661453432;13815.378307975965;9588.616455341988;12545.937270313954;12579.937100314806;12596.496140154291;13192.934035329761;10942.343459392461;12241.756823180536;12514.124011319484;12651.240925544496;12956.028297877885;10788.244822862323;10997.780044398907;11034.282771619819;11075.280106793032;11549.42252887369;7268.309510596485;9997.100260976547;10129.64546240878;10281.691549253534;11221.943890280496 11:37:38 INFO - PID 1651 | __end_tp_report 11:37:38 INFO - PID 1651 | __start_cc_report 11:37:38 INFO - PID 1651 | _x_x_mozilla_cycle_collect,427 11:37:38 INFO - PID 1651 | __end_cc_report 11:37:38 INFO - PID 1651 | __startTimestamp1490121458970__endTimestamp 11:37:38 INFO - PID 1651 | 11:37:38 INFO - PID 1651 | ------- Summary: start ------- 11:37:38 INFO - PID 1651 | Number of tests: 6 11:37:38 INFO - PID 1651 | 11:37:38 INFO - PID 1651 | [#0] dojo.html Cycles:165 Average:6051.15 Median:6336.05 stddev:758.59 (12.0%) stddev-sans-first:734.41 11:37:38 INFO - PID 1651 | Values: 3517.4 3542.6 3548.4 3578.7 3585.2 5113.9 6127.1 6142.0 6219.8 6288.1 6110.9 6198.8 6226.0 6275.5 6301.5 5571.1 5580.2 5736.5 5762.5 5813.0 4574.3 4624.0 5045.3 5523.1 5772.0 4762.8 5311.7 5526.1 5568.8 5627.8 4727.8 5345.2 5533.7 5569.7 5590.2 5454.9 5462.6 5474.6 5553.6 5633.1 4698.7 5438.1 6213.8 6264.2 6273.2 6621.3 6646.3 6656.6 6674.4 6675.1 6432.7 6462.5 6559.9 6597.9 6667.4 5201.1 5478.0 5723.0 5900.8 6370.7 6853.3 6859.2 6906.5 6914.8 6921.3 6348.4 6509.3 6510.2 6518.6 6571.3 6670.0 6683.6 6691.3 6700.6 6717.9 6570.2 6589.7 6597.1 6601.2 6605.0 6310.6 6408.1 6429.8 6553.4 6559.8 5318.3 5344.0 5350.9 5370.0 5370.2 4676.7 4726.2 4740.6 4749.6 4751.9 5216.3 6236.8 6284.8 6294.7 6318.3 6718.7 6767.9 6800.4 6808.9 6829.6 5201.7 6234.2 6319.1 6336.0 6354.4 4702.9 5775.5 5889.1 5891.7 5915.3 6739.3 6919.5 6962.9 6980.8 7002.2 6757.5 6780.7 6780.8 6782.2 6785.3 6430.8 6452.1 6469.9 6892.4 6901.8 5536.2 5910.4 6660.7 6664.3 6672.0 5283.5 5451.6 6352.8 6369.9 6673.4 6340.9 6443.5 6446.9 6453.5 6453.8 6444.0 6450.1 6450.3 6458.9 6459.3 5261.8 6041.6 6259.2 6327.6 6340.9 6423.5 6478.4 6498.4 6505.0 6507.5 6299.5 6358.3 6369.2 6379.8 6403.4 11:37:38 INFO - PID 1651 | 11:37:38 INFO - PID 1651 | [#1] ext.html Cycles:180 Average:50424.55 Median:176563.36 stddev:101138.89 (57.3%) stddev-sans-first:101353.65 11:37:38 INFO - PID 1651 | Values: 679.7 725.0 728.3 790.5 793.8 36463.1 36894.0 37036.9 37070.8 37442.8 36072.3 36542.1 36565.6 36690.1 36882.3 2464.8 2523.2 2668.9 2826.8 2899.2 2464.8 2821.4 2891.9 2893.1 2894.9 2873.0 2882.8 2883.9 2898.1 2899.3 2857.2 2870.0 2886.4 2897.0 2904.8 2863.7 2869.0 2887.7 2892.9 2901.1 36911.6 37235.0 37317.6 38434.4 38574.2 3018.8 3032.8 3036.6 3041.8 3067.5 27023.7 27350.6 27512.3 27691.6 28333.4 2811.3 2825.7 2832.4 2848.1 2867.2 241186.0 316557.0 321389.0 323859.0 325377.0 37535.8 38253.4 45781.0 46691.8 46789.8 48610.3 49032.5 49105.8 49142.8 49186.5 13879.0 13925.9 14062.2 14081.6 14082.3 11389.4 11411.4 11412.0 11569.4 11766.4 12451.3 12457.8 12459.5 12532.7 12562.6 5442.4 5447.0 5452.8 5463.1 5485.6 876.7 904.4 916.4 968.1 972.6 20808.8 21503.2 23603.6 23842.8 24180.4 1040.5 1042.2 1042.8 1078.8 1079.4 11657.9 12201.5 12219.1 12229.8 12253.7 413665.0 415924.0 416410.0 417228.0 418072.0 54252.0 54334.2 54335.5 54403.7 54432.0 1178.6 1415.1 1463.3 1465.4 1469.9 22793.1 23271.2 23399.8 23486.6 23594.9 37178.0 37253.8 37260.4 37271.0 37404.6 405779.0 406913.0 407433.0 408978.0 410707.0 32654.5 33257.3 33277.5 33431.8 33481.2 42008.8 42130.6 43485.7 43577.7 43712.8 35097.6 35224.6 35294.6 36244.0 36320.8 34505.7 34800.0 35558.0 35773.1 35828.8 34546.8 34872.5 35836.0 35984.1 35989.3 30365.5 31559.0 31706.0 31737.7 32390.5 19145.4 23352.8 24051.5 24187.9 24241.2 11:37:38 INFO - PID 1651 | 11:37:38 INFO - PID 1651 | [#2] jquery.html Cycles:180 Average:40394.07 Median:12143.88 stddev:119025.25 (980.1%) stddev-sans-first:119321.27 11:37:38 INFO - PID 1651 | Values: 404.1 414.7 414.7 422.2 436.1 19190.0 20642.2 21141.9 21412.9 21979.8 22085.3 22552.2 22763.8 23564.1 23587.5 3819.7 4187.9 4335.5 4354.8 4362.3 3655.2 4178.4 4285.1 4328.5 4354.5 4246.8 4254.1 4271.6 4279.8 4296.3 4224.5 4259.0 4263.3 4269.0 4283.0 3823.9 3844.1 3877.5 3880.9 3919.7 21749.6 26932.2 27175.2 27302.3 27393.5 1994.4 2005.2 2021.3 2055.6 2098.8 16057.6 16441.0 16633.5 16782.9 17432.4 1686.2 1699.6 1715.3 1718.8 1735.9 124159.4 145895.0 146421.3 150005.0 151252.0 12272.4 12302.8 12386.4 12456.8 12552.5 15913.5 15947.8 15948.2 15955.6 15982.2 8822.8 9004.6 9042.2 9076.2 9173.4 8682.2 8690.4 8692.8 8814.4 8815.7 7080.1 7552.8 7868.2 7984.1 8044.7 2186.1 2190.4 2195.8 2202.4 2526.9 836.6 883.8 938.6 947.2 977.5 17409.9 18333.3 20347.1 20843.7 20884.6 888.2 968.7 979.5 989.9 1005.8 10640.0 10850.9 10962.1 10965.2 10971.4 612379.0 725606.0 726077.0 735841.0 745015.9 123754.0 160945.0 163962.0 164154.4 165541.0 1142.6 1172.0 1190.8 1191.3 1193.0 17341.4 17426.1 18077.8 18507.4 18617.0 59728.7 60719.0 61249.7 61415.0 62429.0 85821.0 85837.6 86954.6 87726.6 88277.6 8508.7 8532.1 8642.2 8752.0 8778.0 13832.8 13838.8 13862.3 14181.6 14298.9 11673.2 11855.7 11872.5 12027.0 12099.1 9822.7 11261.7 11701.9 11857.5 12099.7 10352.6 11236.8 11747.6 12097.8 12185.8 8404.9 8692.0 8782.6 11950.6 12555.9 9716.6 11190.4 11790.5 11924.2 12293.6 11:37:38 INFO - PID 1651 | 11:37:38 INFO - PID 1651 | [#3] mootools.html Cycles:180 Average:6529.26 Median:3885.67 stddev:4019.16 (103.4%) stddev-sans-first:4011.61 11:37:38 INFO - PID 1651 | Values: 1353.0 1396.3 1398.2 1408.5 1421.5 10177.5 10348.0 10539.3 10575.0 10596.5 10402.3 10511.4 10561.8 10580.9 10609.8 2374.6 2393.8 2415.3 2418.1 2418.8 2342.9 2395.7 2396.9 2404.8 2412.3 2367.6 2380.3 2388.2 2391.6 2407.2 2272.5 2352.3 2354.1 2360.4 2375.9 2016.3 2098.2 2310.8 2344.6 2405.2 10516.4 10616.0 10651.0 10815.0 10846.2 5992.4 6207.3 6220.5 6233.4 6236.0 3858.4 3861.5 3909.8 3938.2 3966.5 1103.6 1117.6 1128.4 1182.8 1184.1 13260.6 14384.8 14488.6 14616.8 14624.9 3920.5 4148.8 4370.7 4858.8 5288.1 10925.0 10947.8 10958.3 11008.9 11081.6 6092.8 6102.9 6104.6 6112.9 6116.8 5435.4 5487.6 5556.4 5604.6 5639.5 4091.5 4174.2 4221.3 4246.5 4253.5 1240.6 1246.1 1248.9 1257.8 1268.2 720.2 722.8 749.7 751.1 788.4 4881.0 5600.6 6400.3 6440.6 6460.1 560.5 833.6 861.5 873.9 918.3 3480.3 4038.1 4087.0 4186.7 4200.4 12759.4 12973.0 13091.6 13095.1 13109.5 12971.5 12976.4 13008.7 13027.8 13035.0 9399.2 9777.2 9782.0 9786.7 9811.7 5216.8 6378.9 6446.5 6607.3 6643.3 11878.5 12161.0 12171.2 12250.9 12270.2 12030.5 12123.2 12202.9 12251.7 12261.3 8404.8 8648.6 8792.5 8842.2 8851.5 9774.0 9934.3 10018.0 10018.5 10041.2 8455.7 8686.7 8766.8 8791.9 8867.7 8533.5 8544.6 8579.7 8660.5 8675.7 7474.9 7559.5 7642.4 7646.9 7661.8 4215.6 5078.9 5225.3 5293.4 5387.1 5625.8 5677.2 5683.9 5749.5 5753.2 11:37:38 INFO - PID 1651 | 11:37:38 INFO - PID 1651 | [#4] prototype.html Cycles:180 Average:5352.19 Median:5935.07 stddev:1606.41 (27.1%) stddev-sans-first:1566.96 11:37:38 INFO - PID 1651 | Values: 379.5 380.5 390.0 400.1 402.4 5971.9 6093.8 6212.7 6298.4 6344.6 4283.6 5593.7 6132.8 6157.2 6196.0 4833.6 4835.3 4842.0 4858.9 4867.0 3856.5 4245.0 4701.3 4845.9 4862.9 4711.6 4755.1 4769.7 4785.7 4808.0 3941.7 4268.3 4551.0 4812.4 4831.7 3727.8 3793.5 4031.0 4228.8 4237.9 5976.5 5992.0 5993.9 6026.6 6050.3 5505.9 5571.4 5578.0 5615.5 5628.7 5582.0 6294.2 6512.0 6599.3 6600.2 4699.7 4707.3 4725.7 4726.4 4736.5 6690.9 6874.0 6948.5 6983.5 7015.4 4580.4 4605.8 4634.4 4782.6 4824.9 4093.0 4886.4 4900.0 4908.0 4916.6 5357.4 5475.5 5497.9 5530.6 5536.1 6282.7 6614.2 6640.2 6659.9 6666.8 1476.3 1600.4 1600.6 1644.2 1668.8 1115.8 1150.3 1155.5 1163.4 1168.9 5633.7 5882.4 6179.8 6193.2 6240.4 5724.1 6725.9 6791.3 6805.6 6819.6 5986.9 6081.9 6132.4 6156.2 6200.0 2864.4 3242.9 3519.6 3591.0 3602.9 5705.8 6556.9 6741.6 7053.9 7099.7 5898.2 6902.1 6914.4 6961.4 6984.9 5761.6 6210.8 6474.4 6965.8 7052.4 5401.6 6016.1 6786.8 6806.5 6812.2 5872.4 5985.5 6324.9 6704.5 6709.8 5885.4 6975.1 6980.4 7019.6 7030.2 4600.9 4828.3 4840.2 4847.7 4859.3 5281.6 6148.8 6484.9 6632.9 6792.2 6084.6 6116.4 6330.1 6481.6 6596.3 6182.0 6563.4 6565.8 6570.5 6597.5 5447.4 6371.7 6391.4 6392.2 6422.2 5765.0 6542.7 6565.2 6567.6 6606.3 5541.5 6070.9 6422.9 6426.6 6472.9 11:37:38 INFO - PID 1651 | 11:37:38 INFO - PID 1651 | [#5] yui.html Cycles:180 Average:18911.65 Median:13393.96 stddev:27102.49 (202.3%) stddev-sans-first:27143.84 11:37:38 INFO - PID 1651 | Values: 650.1 676.9 695.9 701.2 712.8 14970.8 15448.8 15605.8 15791.4 16007.2 14718.6 14733.9 14751.6 15023.0 15336.5 922.0 942.6 947.1 949.5 949.6 944.3 949.1 953.2 984.5 992.9 1023.2 1027.4 1033.5 1034.0 1035.1 1027.1 1027.2 1027.6 1029.2 1030.0 754.0 757.9 766.8 770.0 770.4 16149.4 16313.2 16431.3 16722.7 16945.7 11189.6 14727.8 14920.7 14969.8 15171.6 11480.6 11663.5 11668.3 11865.6 12408.4 3005.3 3084.3 3100.5 3155.9 3170.5 110867.0 113458.3 114262.4 115254.2 115738.0 10809.8 11114.1 11182.9 11566.6 11774.2 23295.1 23459.8 23740.8 23742.4 23782.6 7705.2 7783.1 7850.9 7897.9 8074.4 4001.9 4012.6 4046.3 4051.5 4072.3 3987.5 4096.5 4300.8 4487.4 4516.3 778.4 804.3 848.2 851.1 874.2 528.6 535.0 536.9 558.8 578.3 9797.9 10006.5 10423.7 10424.8 10486.3 536.2 561.7 568.3 594.9 595.8 4584.6 4835.8 4872.9 4911.7 4936.8 88087.0 97826.5 98090.0 98325.0 99375.0 58934.1 66272.3 66316.0 87304.0 89195.0 66515.0 67091.7 67339.7 67977.7 68610.3 10135.9 10610.5 10636.5 10679.3 10703.9 31304.7 33945.7 36346.6 36799.6 37368.3 47920.6 47963.0 48524.8 48713.3 48798.8 13074.3 13118.8 13124.1 13446.1 13539.4 12004.6 14111.3 14266.8 14290.8 14407.1 13307.9 13355.5 13380.1 13408.5 13815.4 9588.6 12545.9 12579.9 12596.5 13192.9 10942.3 12241.8 12514.1 12651.2 12956.0 10788.2 10997.8 11034.3 11075.3 11549.4 7268.3 9997.1 10129.6 10281.7 11221.9 11:37:38 INFO - PID 1651 | -------- Summary: end -------- 11:37:38 INFO - PID 1651 | 11:37:39 INFO - TEST-INFO | 1651: exit 0 11:37:39 INFO - TEST-OK | dromaeo_css | took 1117177ms 11:37:39 INFO - TEST-START | kraken 11:37:39 INFO - operating with platform_type : mac_ 11:37:39 INFO - Initialising browser for kraken test... 11:37:39 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/tmpjQmPmg/profile http://localhost:49236/getInfo.html) 11:37:42 INFO - PID 1664 | 2017-03-21 11:37:42.657 plugin-container[1665:10179] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 11:37:42 INFO - PID 1664 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:37:42 INFO - PID 1664 | 2017-03-21 11:37:42.659 plugin-container[1665:10179] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x910b, name = 'com.apple.CFPasteboardClient' 11:37:42 INFO - PID 1664 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:37:42 INFO - PID 1664 | 2017-03-21 11:37:42.659 plugin-container[1665:10179] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:37:42 INFO - PID 1664 | __metrics Screen width/height:1600/1200 11:37:42 INFO - PID 1664 | colorDepth:24 11:37:42 INFO - PID 1664 | Browser inner width/height: 1024/689 11:37:42 INFO - PID 1664 | __metrics 11:37:42 ERROR - PID 1664 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3350: TypeError: this.tabs is undefined 11:37:43 INFO - TEST-INFO | 1664: exit 0 11:37:43 INFO - Browser initialized. 11:37:43 INFO - Running cycle 1/1 for kraken test... 11:37:43 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/T/tmpjQmPmg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:37:46 INFO - PID 1666 | 2017-03-21 11:37:46.115 plugin-container[1667:10295] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a4b, name = 'com.apple.tsm.portname' 11:37:46 INFO - PID 1666 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:37:46 INFO - PID 1666 | 2017-03-21 11:37:46.115 plugin-container[1667:10295] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9017, name = 'com.apple.CFPasteboardClient' 11:37:46 INFO - PID 1666 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:37:46 INFO - PID 1666 | 2017-03-21 11:37:46.115 plugin-container[1667:10295] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:37:55 INFO - PID 1666 | RSS: Main: 227622912 11:37:55 INFO - PID 1666 | 11:37:58 INFO - PID 1666 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection) 11:37:59 INFO - PID 1666 | RSS: Main: 241774592 11:37:59 INFO - PID 1666 | 11:38:02 INFO - PID 1666 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-dft) 11:38:02 INFO - PID 1666 | RSS: Main: 250257408 11:38:02 INFO - PID 1666 | 11:38:06 INFO - PID 1666 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-fft) 11:38:06 INFO - PID 1666 | RSS: Main: 252633088 11:38:06 INFO - PID 1666 | 11:38:08 INFO - PID 1666 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator) 11:38:09 INFO - PID 1666 | RSS: Main: 254005248 11:38:09 INFO - PID 1666 | 11:38:11 INFO - PID 1666 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:38:12 INFO - PID 1666 | RSS: Main: 255664128 11:38:12 INFO - PID 1666 | 11:38:15 INFO - PID 1666 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom) 11:38:15 INFO - PID 1666 | RSS: Main: 261509120 11:38:15 INFO - PID 1666 | 11:38:18 INFO - PID 1666 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate) 11:38:19 INFO - PID 1666 | RSS: Main: 261812224 11:38:19 INFO - PID 1666 | 11:38:22 INFO - PID 1666 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial) 11:38:23 INFO - PID 1666 | RSS: Main: 261992448 11:38:23 INFO - PID 1666 | 11:38:25 INFO - PID 1666 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:38:25 INFO - PID 1666 | RSS: Main: 261496832 11:38:25 INFO - PID 1666 | 11:38:27 INFO - PID 1666 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:38:28 INFO - PID 1666 | RSS: Main: 261484544 11:38:28 INFO - PID 1666 | 11:38:30 INFO - PID 1666 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:38:31 INFO - PID 1666 | RSS: Main: 261586944 11:38:31 INFO - PID 1666 | 11:38:34 INFO - PID 1666 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:38:35 INFO - PID 1666 | RSS: Main: 262246400 11:38:35 INFO - PID 1666 | 11:38:38 INFO - PID 1666 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:38:38 INFO - PID 1666 | RSS: Main: 261758976 11:38:38 INFO - PID 1666 | 11:38:40 INFO - PID 1666 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49236/tests/kraken/driver.html?testName=ai-astar) 11:38:40 INFO - PID 1666 | RSS: Main: 263327744 11:38:40 INFO - PID 1666 | 11:38:40 INFO - PID 1666 | __start_tp_report 11:38:40 INFO - PID 1666 | _x_x_mozilla_page_load 11:38:40 INFO - PID 1666 | _x_x_mozilla_page_load_details 11:38:40 INFO - PID 1666 | |i|pagename|runs| 11:38:40 INFO - PID 1666 | |0;ai-astar;104;117;116;115;115;116;114;168;113;118 11:38:40 INFO - PID 1666 | |1;audio-beat-detection;144;116;115;154;114;113;117;115;132;115 11:38:40 INFO - PID 1666 | |2;audio-dft;196;204;206;218;207;245;201;200;198;196 11:38:40 INFO - PID 1666 | |3;audio-fft;88;59;59;87;59;58;58;57;76;76 11:38:40 INFO - PID 1666 | |4;audio-oscillator;82;69;86;72;72;73;121;107;105;91 11:38:40 INFO - PID 1666 | |5;imaging-gaussian-blur;122;89;89;90;89;111;113;136;93;136 11:38:40 INFO - PID 1666 | |6;imaging-darkroom;96;98;96;97;96;95;102;97;97;96 11:38:40 INFO - PID 1666 | |7;imaging-desaturate;144;142;95;145;126;82;77;152;75;147 11:38:40 INFO - PID 1666 | |8;json-parse-financial;71;66;66;67;70;67;67;67;68;68 11:38:40 INFO - PID 1666 | |9;json-stringify-tinderbox;59;62;59;60;74;65;58;52;84;84 11:38:40 INFO - PID 1666 | |10;stanford-crypto-aes;99;110;108;76;102;109;109;85;85;108 11:38:40 INFO - PID 1666 | |11;stanford-crypto-ccm;156;153;143;150;174;158;156;140;222;141 11:38:40 INFO - PID 1666 | |12;stanford-crypto-pbkdf2;189;188;197;202;177;186;186;182;185;187 11:38:40 INFO - PID 1666 | |13;stanford-crypto-sha256-iterative;69;67;70;64;66;68;70;68;66;72 11:38:40 INFO - PID 1666 | __end_tp_report 11:38:40 INFO - PID 1666 | __start_cc_report 11:38:40 INFO - PID 1666 | _x_x_mozilla_cycle_collect,998 11:38:40 INFO - PID 1666 | __end_cc_report 11:38:40 INFO - PID 1666 | __startTimestamp1490121520834__endTimestamp 11:38:40 INFO - PID 1666 | 11:38:40 INFO - PID 1666 | ------- Summary: start ------- 11:38:40 INFO - PID 1666 | Number of tests: 14 11:38:40 INFO - PID 1666 | 11:38:40 INFO - PID 1666 | [#0] ai-astar Cycles:10 Average:119.60 Median:116.00 stddev:17.44 (15.0%) stddev-sans-first:17.56 11:38:40 INFO - PID 1666 | Values: 104.0 117.0 116.0 115.0 115.0 116.0 114.0 168.0 113.0 118.0 11:38:40 INFO - PID 1666 | 11:38:40 INFO - PID 1666 | [#1] audio-beat-detection Cycles:10 Average:123.50 Median:116.50 stddev:14.68 (12.6%) stddev-sans-first:13.56 11:38:40 INFO - PID 1666 | Values: 144.0 116.0 115.0 154.0 114.0 113.0 117.0 115.0 132.0 115.0 11:38:40 INFO - PID 1666 | 11:38:40 INFO - PID 1666 | [#2] audio-dft Cycles:10 Average:207.10 Median:205.00 stddev:14.84 (7.2%) stddev-sans-first:15.19 11:38:40 INFO - PID 1666 | Values: 196.0 204.0 206.0 218.0 207.0 245.0 201.0 200.0 198.0 196.0 11:38:40 INFO - PID 1666 | 11:38:40 INFO - PID 1666 | [#3] audio-fft Cycles:10 Average:67.70 Median:67.50 stddev:12.70 (18.8%) stddev-sans-first:11.15 11:38:40 INFO - PID 1666 | Values: 88.0 59.0 59.0 87.0 59.0 58.0 58.0 57.0 76.0 76.0 11:38:40 INFO - PID 1666 | 11:38:40 INFO - PID 1666 | [#4] audio-oscillator Cycles:10 Average:87.80 Median:72.50 stddev:17.91 (24.7%) stddev-sans-first:18.87 11:38:40 INFO - PID 1666 | Values: 82.0 69.0 86.0 72.0 72.0 73.0 121.0 107.0 105.0 91.0 11:38:40 INFO - PID 1666 | 11:38:40 INFO - PID 1666 | [#5] imaging-gaussian-blur Cycles:10 Average:106.80 Median:89.00 stddev:19.48 (21.9%) stddev-sans-first:19.87 11:38:40 INFO - PID 1666 | Values: 122.0 89.0 89.0 90.0 89.0 111.0 113.0 136.0 93.0 136.0 11:38:40 INFO - PID 1666 | 11:38:40 INFO - PID 1666 | [#6] imaging-darkroom Cycles:10 Average:97.00 Median:96.50 stddev:1.94 (2.0%) stddev-sans-first:2.03 11:38:40 INFO - PID 1666 | Values: 96.0 98.0 96.0 97.0 96.0 95.0 102.0 97.0 97.0 96.0 11:38:40 INFO - PID 1666 | 11:38:40 INFO - PID 1666 | [#7] imaging-desaturate Cycles:10 Average:118.50 Median:113.50 stddev:32.31 (28.5%) stddev-sans-first:32.92 11:38:40 INFO - PID 1666 | Values: 144.0 142.0 95.0 145.0 126.0 82.0 77.0 152.0 75.0 147.0 11:38:40 INFO - PID 1666 | 11:38:40 INFO - PID 1666 | [#8] json-parse-financial Cycles:10 Average:67.70 Median:67.50 stddev:1.64 (2.4%) stddev-sans-first:1.22 11:38:40 INFO - PID 1666 | Values: 71.0 66.0 66.0 67.0 70.0 67.0 67.0 67.0 68.0 68.0 11:38:40 INFO - PID 1666 | 11:38:40 INFO - PID 1666 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:63.50 stddev:11.17 (17.6%) stddev-sans-first:11.58 11:38:40 INFO - PID 1666 | Values: 59.0 62.0 59.0 60.0 74.0 65.0 58.0 52.0 84.0 84.0 11:38:40 INFO - PID 1666 | 11:38:40 INFO - PID 1666 | [#10] stanford-crypto-aes Cycles:10 Average:99.10 Median:93.00 stddev:12.53 (13.5%) stddev-sans-first:13.29 11:38:40 INFO - PID 1666 | Values: 99.0 110.0 108.0 76.0 102.0 109.0 109.0 85.0 85.0 108.0 11:38:40 INFO - PID 1666 | 11:38:40 INFO - PID 1666 | [#11] stanford-crypto-ccm Cycles:10 Average:159.30 Median:156.00 stddev:24.20 (15.5%) stddev-sans-first:25.64 11:38:40 INFO - PID 1666 | Values: 156.0 153.0 143.0 150.0 174.0 158.0 156.0 140.0 222.0 141.0 11:38:40 INFO - PID 1666 | 11:38:40 INFO - PID 1666 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:187.90 Median:187.50 stddev:7.09 (3.8%) stddev-sans-first:7.51 11:38:40 INFO - PID 1666 | Values: 189.0 188.0 197.0 202.0 177.0 186.0 186.0 182.0 185.0 187.0 11:38:40 INFO - PID 1666 | 11:38:40 INFO - PID 1666 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.50 stddev:2.36 (3.4%) stddev-sans-first:2.47 11:38:40 INFO - PID 1666 | Values: 69.0 67.0 70.0 64.0 66.0 68.0 70.0 68.0 66.0 72.0 11:38:40 INFO - PID 1666 | -------- Summary: end -------- 11:38:40 INFO - PID 1666 | 11:38:41 INFO - TEST-INFO | 1666: exit 0 11:38:41 INFO - TEST-OK | kraken | took 62064ms 11:38:41 INFO - SUITE-END | took 1179s 11:38:41 INFO - Completed test suite (00:19:39) 11:38:41 INFO - javascript benchmark 11:38:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7354.753356933381, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3517.366873962687, 3542.592601850788, 3548.414511605585, 3578.695810856077, 3585.157487990322, 5113.897722045562, 6127.050307202385, 6141.986572215579, 6219.751209951596, 6288.119663247149, 6110.892920173598, 6198.845028874281, 6226.0, 6275.497960163188, 6301.527385446098, 5571.0807716726695, 5580.162975553659, 5736.512396446307, 5762.4525670061485, 5813.0, 4574.313852922055, 4623.9768801156115, 5045.318881950926, 5523.1163013917785, 5771.971140144294, 4762.761861906891, 5311.707856067915, 5526.143447765603, 5568.832935011957, 5627.803026894059, 4727.818045488628, 5345.224942383372, 5533.667979921218, 5569.749361278712, 5590.161475778625, 5454.945450545483, 5462.562994960394, 5474.562035037187, 5553.555715542747, 5633.126865335838, 4698.671093023489, 5438.075527160392, 6213.782517611907, 6264.248290205159, 6273.1531243282025, 6621.337866213388, 6646.335366463363, 6656.633885136315, 6674.432673222782, 6675.098861653663, 6432.678366081724, 6462.547621666486, 6559.868802623921, 6597.93402065978, 6667.433268172211, 5201.115810312181, 5478.0, 5723.02708539541, 5900.822975310747, 6370.681465926731, 6853.314668533107, 6859.17689877208, 6906.516543841984, 6914.757983470555, 6921.307869213139, 6348.396902294275, 6509.349065093547, 6510.21877374718, 6518.608883467007, 6571.31001244872, 6670.032845237413, 6683.6324002180345, 6691.26396096429, 6700.597964122168, 6717.865642687118, 6570.211574611078, 6589.703463344065, 6597.1423714916755, 6601.174853143357, 6604.976228684562, 6310.5898116622275, 6408.070829729663, 6429.839254018687, 6553.377429144223, 6559.8032059038305, 5318.282031925641, 5344.038073146871, 5350.8662283442445, 5370.006548788487, 5370.221317908881, 4676.69601475903, 4726.196546587088, 4740.620750339965, 4749.596284315872, 4751.881202969884, 5216.347956505437, 6236.781712640036, 6284.780032698834, 6294.716737746812, 6318.336574659686, 6718.7312507499155, 6767.864642707118, 6800.387965083166, 6808.863822723518, 6829.6243706596615, 5201.739913004335, 6234.1583886175695, 6319.0837328587095, 6336.049592561153, 6354.428101470798, 4702.882427939329, 5775.451332123442, 5889.087191485327, 5891.7054147292465, 5915.260592425947, 6739.258681544928, 6919.515633905578, 6962.860742785218, 6980.7905762827195, 7002.1947476040905, 6757.493188011017, 6780.660966951534, 6780.796576102724, 6782.152230971129, 6785.287544807724, 6430.7749228776765, 6452.096706461005, 6469.902951455826, 6892.448604111759, 6901.75843845463, 5536.2249285100925, 5910.438508341701, 6660.700268487833, 6664.333566643297, 6672.032555279555, 5283.471652834686, 5451.563874890078, 6352.792969335811, 6369.87260254783, 6673.399394054559, 6340.9048864268, 6443.484521238383, 6446.871062578816, 6453.51598630114, 6453.774117905851, 6443.96778016107, 6450.096986421999, 6450.258220304725, 6458.903116453163, 6459.257185423737, 5261.842144735664, 6041.607295525777, 6259.2488901332135, 6327.557071004985, 6340.904886426615, 6423.454006409321, 6478.352164783484, 6498.3826536478955, 6505.024246363083, 6507.511936604679, 6299.527535434952, 6358.300586935341, 6369.235691717024, 6379.808605741835, 6403.359664033559], "value": 6003.672372041766, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [679.6703598754603, 724.9710011599536, 728.2899173306027, 790.537535541708, 793.773774474275, 36463.08842278944, 36894.0, 37036.88889333318, 37070.8146459268, 37442.81278593607, 36072.27855442896, 36542.08644783882, 36565.634343656624, 36690.082747931316, 36882.262354752886, 2464.8151388645924, 2523.205190365029, 2668.8799004044818, 2826.8162569433025, 2899.246195989037, 2464.8397854139425, 2821.4216085702483, 2891.927701807451, 2893.0597555794347, 2894.898678546251, 2872.971270287291, 2882.8126171798767, 2883.927901802451, 2898.116074597247, 2899.3186601148714, 2857.171420288135, 2870.038537090077, 2886.408286301303, 2897.029495119127, 2904.8111872728205, 2863.6706778720504, 2868.9815115634065, 2887.7112288771164, 2892.942141157186, 2901.0571564241704, 36911.63088369136, 37235.0, 37317.62682373168, 38434.42348364777, 38574.22851542953, 3018.77359198061, 3032.848357582134, 3036.6052413186144, 3041.8022828516296, 3067.4631939410515, 27023.729762702515, 27350.589741153897, 27512.312192195153, 27691.584626230622, 28333.433331333465, 2811.2550174203852, 2825.6609206895305, 2832.4335132973283, 2848.1313199474152, 2867.1828528869173, 241186.0, 316557.0, 321389.0, 323859.0, 325376.9999999976, 37535.81232093822, 38253.42619860704, 45781.0, 46691.766541167075, 46789.830254243236, 48610.27084593734, 49032.50967490351, 49105.75447122742, 49142.75428622834, 49186.50813491819, 13879.028468007344, 13925.930370348084, 14062.22657753813, 14081.647958801112, 14082.295885205698, 11389.430528473544, 11411.42942852854, 11412.0, 11569.363684997237, 11766.352850593299, 12451.25292482454, 12457.813132803016, 12459.501619935101, 12532.749345013232, 12562.560310389092, 5442.401335853053, 5446.972765136228, 5452.836414907559, 5463.098588732814, 5485.61600687948, 876.6756300168978, 904.3895370624801, 916.4134953629682, 968.1238479176357, 972.6401231544232, 20808.79191208099, 21503.2473863414, 23603.645945310833, 23842.761572384403, 24180.395490112536, 1040.484959944832, 1042.166266986408, 1042.838360054193, 1078.8112080385902, 1079.3501952706088, 11657.941710291394, 12201.45093470796, 12219.144659873724, 12229.816552751716, 12253.69365765863, 413665.0, 415924.0, 416410.0, 417228.0, 418072.0, 54252.0, 54334.18498722522, 54335.45664543304, 54403.72798135984, 54432.0, 1178.6169494914186, 1415.0731271017294, 1463.2610531681432, 1465.4211586423517, 1469.8971072024856, 22793.088276469418, 23271.185508507122, 23399.76600233976, 23486.64770028485, 23594.882025589763, 37178.0, 37253.81373093117, 37260.44109338308, 37271.0, 37404.62595374011, 405779.0, 406913.0, 407433.0, 408978.0, 410707.0, 32654.51018234776, 33257.334853303284, 33277.50083748794, 33431.83284083564, 33481.16297092495, 42008.78995605002, 42130.578694212665, 43485.69542913717, 43577.69266921998, 43712.78143609261, 35097.64902350944, 35224.647753522135, 35294.64705353016, 36244.0, 36320.81839590785, 34505.654943450245, 34799.95600132, 35558.0, 35773.10567235736, 35828.82085589555, 34546.82726586351, 34872.47691284582, 35836.0, 35984.10039749027, 35989.28021439609, 30365.544516831822, 31559.0, 31706.04881853548, 31737.715408420492, 32390.514142287415, 19145.425637230906, 23352.76647233506, 24051.51896962016, 24187.879060604584, 24241.151559695325], "value": 14874.221803502045, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [404.06257482640285, 414.7055590530723, 414.70763112006057, 422.1514755341763, 436.12339198211583, 19190.040497975097, 20642.17431302748, 21141.942902854873, 21412.89293553532, 21979.780202197973, 22085.33743987679, 22552.21067262646, 22763.772362276373, 23564.11192153297, 23587.528249435, 3819.6562309392148, 4187.895302617444, 4335.501417336999, 4354.847580334689, 4362.302031674933, 3655.232401195752, 4178.394132850734, 4285.142971405716, 4328.458942632171, 4354.542773008836, 4246.80889359978, 4254.085371645096, 4271.63691086258, 4279.828806847722, 4296.334068219416, 4224.5353011168745, 4259.020425302167, 4263.275243208662, 4269.018125831045, 4283.01490657149, 3823.8661646842506, 3844.0582057395836, 3877.5265399148143, 3880.8641697540734, 3919.7452165609143, 21749.565008699894, 26932.192034239004, 27175.1847444577, 27302.317442064108, 27393.45213095727, 1994.411648563677, 2005.1979208316643, 2021.2521367094268, 2055.599158164159, 2098.7691353951054, 16057.598560036093, 16441.0, 16633.50099497017, 16782.916085419616, 17432.389866354744, 1686.241191463834, 1699.5808499902596, 1715.2624371520242, 1718.8367105124994, 1735.9132043397778, 124159.37920310431, 145895.0, 146421.2678936609, 150005.0, 151252.0, 12272.447739851728, 12302.81545776814, 12386.442610082388, 12456.75086498265, 12552.497900084078, 15913.522594322189, 15947.760783588023, 15948.165960914643, 15955.601109972344, 15982.200889955455, 8822.75019869929, 9004.63981440735, 9042.18620324174, 9076.183143517115, 9173.44959302444, 8682.218600325874, 8690.391672582859, 8692.78268043304, 8814.427062241062, 8815.691450799191, 7080.114985626797, 7552.811179720441, 7868.173841746649, 7984.081830589556, 8044.718434854752, 2186.147402513021, 2190.408589680809, 2195.813355864769, 2202.41635966469, 2526.9386857519885, 836.6151570277618, 883.8302610416924, 938.6245501799335, 947.1570302430843, 977.5405559387077, 17409.868358556654, 18333.266669333345, 20347.08438120288, 20843.749375037547, 20884.582308353747, 888.2272422992038, 968.6851773173606, 979.4564016970508, 989.8564708117283, 1005.7586179316911, 10639.98920102589, 10850.945745271381, 10962.068224200873, 10965.232433729721, 10971.396573188551, 612379.0, 725606.0, 726077.0, 735841.0, 745015.9485646317, 123754.0, 160945.0, 163962.0, 164154.3584564163, 165541.0, 1142.5772464188303, 1171.988280117205, 1190.827330037157, 1191.2733232728028, 1192.9978817793096, 17341.393051243147, 17426.128693565017, 18077.819221807615, 18507.35224267144, 18617.0, 59728.70135649294, 60719.0, 61249.69375153274, 61415.0, 62429.0, 85821.0, 85837.57081214554, 86954.56522717346, 87726.5613671953, 88277.55861220653, 8508.74473765788, 8532.146785321418, 8642.178992995656, 8752.0, 8778.0, 13832.792508112185, 13838.792418113535, 13862.306884655929, 14181.645458863612, 14298.928505357406, 11673.241239319757, 11855.70360740954, 11872.525098995944, 12027.037836973197, 12099.092568057255, 9822.705318840446, 11261.71845703864, 11701.88298117008, 11857.466414011562, 12099.697507562381, 10352.585896564053, 11236.775264494829, 11747.647570572897, 12097.75804483923, 12185.756284874076, 8404.915950840414, 8692.0, 8782.56087195625, 11950.641480755592, 12555.93722031384, 9716.562754676197, 11190.384528850991, 11790.528378864748, 11924.165308428326, 12293.56972505958], "value": 9917.661226119744, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1353.0, 1396.3088271305705, 1398.1680899864577, 1408.5492642354445, 1421.4598452588018, 10177.542010609523, 10348.016938390841, 10539.262251642389, 10574.99999999999, 10596.523156457959, 10402.323848949813, 10511.421871797049, 10561.841572376421, 10580.941905809415, 10609.78780424391, 2374.631932050535, 2393.808495320379, 2415.2995631266913, 2418.056957786465, 2418.7581241875846, 2342.8594284342907, 2395.724491683461, 2396.940076498084, 2404.7955923746504, 2412.2522018174336, 2367.597508423572, 2380.33350661815, 2388.164142550111, 2391.5934291170456, 2407.181558270188, 2272.4773302140434, 2352.3060697094397, 2354.081908055851, 2360.3509035015422, 2375.857448553075, 2016.2842191022269, 2098.192196004534, 2310.7920287174065, 2344.5662552427857, 2405.1702162753822, 10516.369017858953, 10616.0, 10650.988156125233, 10814.972577605115, 10846.240763146583, 5992.370801065869, 6207.34822843604, 6220.502359811204, 6233.438990490832, 6236.03341482071, 3858.4405261237243, 3861.5366156061173, 3909.8045097745285, 3938.1532970411213, 3966.484357033596, 1103.624767579027, 1117.6144230240554, 1128.424503503211, 1182.816663417163, 1184.1296646964474, 13260.602181934653, 14384.784228236585, 14488.565343039725, 14616.780748288784, 14624.853751462455, 3920.4511368408444, 4148.8133034013545, 4370.737755734666, 4858.7570621469495, 5288.101022826128, 10925.0, 10947.83578246327, 10958.342499450058, 11008.889911100947, 11081.612143574936, 6092.847678808065, 6102.877942441215, 6104.603200791934, 6112.938870611237, 6116.785912493041, 5435.374931882805, 5487.5884308677005, 5556.444355564492, 5604.551635869121, 5639.548836093103, 4091.5098933643567, 4174.186033723456, 4221.303484925014, 4246.532881383046, 4253.468316460442, 1240.6092080994638, 1246.1463897230426, 1248.875112488762, 1257.7610254051701, 1268.1883594499527, 720.204174387305, 722.8012296618472, 749.7113611259705, 751.1174370115093, 788.4086934798901, 4880.975595122001, 5600.60795744294, 6400.327965563642, 6440.6135631862235, 6460.127882735865, 560.5431573267774, 833.5748768128299, 861.5175501718932, 873.8951325840812, 918.3112665500875, 3480.269143479847, 4038.0914294283552, 4087.0, 4186.727862688916, 4200.369944508348, 12759.405074365704, 12973.027022973314, 13091.607251782461, 13095.083344165816, 13109.475620975245, 12971.481140754264, 12976.416061277265, 13008.674783130498, 13027.804582931263, 13035.0, 9399.201067909167, 9777.217822574177, 9781.951090244504, 9786.706398808046, 9811.656592019244, 5216.765245563883, 6378.936210637834, 6446.484281257582, 6607.339266073354, 6643.269240383651, 11878.46546905374, 12161.0, 12171.208871423329, 12250.877491224974, 12270.202436841577, 12030.518779249081, 12123.211991220895, 12202.938985305016, 12251.69370765738, 12261.264324140224, 8404.789880253042, 8648.567571621268, 8792.47245165292, 8842.24840888506, 8851.513166775889, 9773.951130244302, 9934.304598678023, 10018.048285412875, 10018.549165287724, 10041.196704263495, 8455.661773529237, 8686.652533898827, 8766.824663506566, 8791.868121978303, 8867.68963086289, 8533.53065581399, 8544.615492302737, 8579.65681372738, 8660.523671198145, 8675.652973881226, 7474.92525074764, 7559.5464272143845, 7642.426817988562, 7646.923530764621, 7661.846763064819, 4215.57844215576, 5078.873028174326, 5225.268462415189, 5293.364796224324, 5387.111126664056, 5625.774969001194, 5677.1768093627015, 5683.8863222736145, 5749.540036796962, 5753.1945527627], "value": 4981.821126973794, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.50664136622385, 380.518643915447, 390.0307735277836, 400.11774038245665, 402.3903785764567, 5971.940280597193, 6093.847653808657, 6212.689365531728, 6298.362425769298, 6344.555881088326, 4283.635890949266, 5593.664380137195, 6132.773445310933, 6157.199564056677, 6196.008638617811, 4833.637477189216, 4835.298881662157, 4842.0, 4858.902821943559, 4866.951330486685, 3856.5179352580926, 4244.957550424487, 4701.3418121462855, 4845.927311090337, 4862.927056094161, 4711.623070154396, 4755.096531658991, 4769.689970151929, 4785.66500344976, 4808.0, 3941.6649584785328, 4268.274393353137, 4551.0215303709865, 4812.398450193726, 4831.685940413862, 3727.8136093195503, 3793.468914351993, 4031.0325521874834, 4228.830846766125, 4237.915241695149, 5976.46211840932, 5992.0, 5993.910091348634, 6026.578139530235, 6050.27396712393, 5505.889882202334, 5571.428571428572, 5578.0, 5615.522680572156, 5628.718564071821, 5582.0, 6294.150289710876, 6511.958086706104, 6599.3070727573395, 6600.194917160187, 4699.7415142167165, 4707.340972263886, 4725.740084295362, 4726.4328280606205, 4736.478987311393, 6690.933090669079, 6873.965630171817, 6948.548344357651, 6983.511154219207, 7015.4036906862975, 4580.427446569179, 4605.825514493783, 4634.443866736014, 4782.641301902302, 4824.903501929942, 4093.0, 4886.413630364308, 4900.0, 4907.950940474123, 4916.5820905222745, 5357.383900851452, 5475.534579560703, 5497.862553436116, 5530.5852061095575, 5536.114221724505, 6282.748690052438, 6614.206295244601, 6640.236372817091, 6659.9001014984815, 6666.83332916681, 1476.3430273528177, 1600.3678546974113, 1600.5518454832666, 1644.2436479219693, 1668.8414600612923, 1115.83820346051, 1150.2638311480491, 1155.5377848860355, 1163.4008485629906, 1168.9123315751353, 5633.718314084279, 5882.3529411764675, 6179.783707570304, 6193.225846769154, 6240.4071613196675, 5724.084146536534, 6725.8654826903185, 6791.320867913169, 6805.584017673655, 6819.601981593861, 5986.850328741816, 6081.908771368433, 6132.356102609251, 6156.168917196122, 6200.007998720183, 2864.3984763199546, 3242.9351412972082, 3519.6480351964597, 3590.982045089758, 3602.945955810665, 5705.800296989669, 6556.885329493997, 6741.629210393377, 7053.89419158713, 7099.716011359487, 5898.203742494708, 6902.101921971498, 6914.412274956584, 6961.443084553223, 6984.860302793915, 5761.596688231867, 6210.844728881814, 6474.449671777952, 6965.825854353681, 7052.435805135577, 5401.594880384066, 6016.059481039926, 6786.796396108125, 6806.455483561204, 6812.182538095461, 5872.354041055566, 5985.545926170249, 6324.936750632435, 6704.530682852153, 6709.798706038827, 5885.440883116097, 6975.128108986377, 6980.406665433495, 7019.6490175492045, 7030.226675065636, 4600.930986035279, 4828.348172996601, 4840.201366774443, 4847.733374664427, 4859.31969524274, 5281.630285879952, 6148.815535533941, 6484.870302594016, 6632.933670663425, 6792.218894827158, 6084.60450070744, 6116.360765344612, 6330.132610879894, 6481.578697384655, 6596.340365963365, 6181.9690901547, 6563.3764792344655, 6565.770198043046, 6570.507211959027, 6597.538172327891, 5447.3735520414075, 6371.74513019474, 6391.360863913572, 6392.20097487814, 6422.197225346832, 5765.0, 6542.705578248895, 6565.244996825235, 6567.620799632131, 6606.306337834651, 5541.473560011793, 6070.939290607214, 6422.871542569216, 6426.61440313564, 6472.902906456501], "value": 4856.0859736376115, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [650.1190886348998, 676.8849295619746, 695.9408450281726, 701.2356531380794, 712.8360477090266, 14970.775438368419, 15448.845511544881, 15605.84394156061, 15791.447299344525, 16007.199640017996, 14718.63203419915, 14733.92633036836, 14751.557453276391, 15023.0, 15336.46322378717, 922.0180507759248, 942.6465075596651, 947.1239103828965, 949.4967667136428, 949.6486300068984, 944.3200895355333, 949.103097572794, 953.2469349214113, 984.5421878826344, 992.8907820139815, 1023.2070145637116, 1027.3835698580867, 1033.503918119303, 1034.0, 1035.083950703625, 1027.085893554737, 1027.1525991057408, 1027.594100330369, 1029.2280789407944, 1029.9957541397152, 753.9924600754032, 757.8673732096861, 766.8044648614567, 770.0297624992494, 770.4067867741863, 16149.434769783118, 16313.184340783033, 16431.26059327333, 16722.66554668912, 16945.66108677832, 11189.608363707313, 14727.779083313759, 14920.70158596822, 14969.775453368207, 15171.62070948224, 11480.598179063692, 11663.533458661643, 11668.299902005821, 11865.644030679094, 12408.379581021003, 3005.2787331040613, 3084.290613158986, 3100.527409301574, 3155.857986390618, 3170.508571171472, 110867.0, 113458.29812552818, 114262.42868785685, 115254.16949966058, 115738.0, 10809.83785243222, 11114.11087113029, 11182.944085279685, 11566.595169169039, 11774.234674746114, 23295.06819727226, 23459.765402345758, 23740.7625923742, 23742.406439838796, 23782.64326035111, 7705.1524332324525, 7783.104942931522, 7850.921490785133, 7897.921020789833, 8074.434789564792, 4001.9399709004388, 4012.598740126022, 4046.3323551614244, 4051.47330846988, 4072.3077076897, 3987.52149742027, 4096.549379568245, 4300.78496075195, 4487.41663583732, 4516.277395616686, 778.4395235430482, 804.2801692485193, 848.1687945813138, 851.1275942159212, 874.1651722604897, 528.5507318779007, 534.986625334362, 536.9033573956647, 558.7541481748099, 578.3060327606888, 9797.902020979842, 10006.49967501622, 10423.68728938133, 10424.843627345595, 10486.318389304823, 536.246573564143, 561.6882630140229, 568.2584227582961, 594.872102497965, 595.7557401465378, 4584.587387135174, 4835.830745923876, 4872.920231099251, 4911.656184067152, 4936.802527898915, 88087.0, 97826.53260201102, 98090.01909980952, 98325.0, 99375.0, 58934.11598826021, 66272.33727662759, 66316.0, 87304.0, 89195.0, 66515.0, 67091.66454167795, 67339.66330168318, 67977.66011169912, 68610.3138968614, 10135.949320253352, 10610.469476526298, 10636.468176591294, 10679.252452328263, 10703.946480267548, 31304.686953130178, 33945.660543395235, 36346.63653363432, 36799.63200367962, 37368.25263494769, 47920.56238312856, 47963.0, 48524.757376212896, 48713.26930095981, 48798.756006219744, 13074.346282685638, 13118.803217951929, 13124.14693044949, 13446.058775885986, 13539.390727417092, 12004.639860804189, 14111.2944352784, 14266.785998210244, 14290.785638215642, 14407.135571865721, 13307.866921330662, 13355.465781369025, 13380.063395562218, 13408.463661453432, 13815.378307975965, 9588.616455341988, 12545.937270313954, 12579.937100314806, 12596.496140154291, 13192.934035329761, 10942.343459392461, 12241.756823180536, 12514.124011319484, 12651.240925544496, 12956.028297877885, 10788.244822862323, 10997.780044398907, 11034.282771619819, 11075.280106793032, 11549.42252887369, 7268.309510596485, 9997.100260976547, 10129.64546240878, 10281.691549253534, 11221.943890280496], "value": 7386.6453773558105, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1575.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 117.0, 116.0, 115.0, 115.0, 116.0, 114.0, 168.0, 113.0, 118.0], "value": 119.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 116.0, 115.0, 154.0, 114.0, 113.0, 117.0, 115.0, 132.0, 115.0], "value": 123.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 204.0, 206.0, 218.0, 207.0, 245.0, 201.0, 200.0, 198.0, 196.0], "value": 207.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 59.0, 59.0, 87.0, 59.0, 58.0, 58.0, 57.0, 76.0, 76.0], "value": 67.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 69.0, 86.0, 72.0, 72.0, 73.0, 121.0, 107.0, 105.0, 91.0], "value": 87.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 89.0, 89.0, 90.0, 89.0, 111.0, 113.0, 136.0, 93.0, 136.0], "value": 106.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 98.0, 96.0, 97.0, 96.0, 95.0, 102.0, 97.0, 97.0, 96.0], "value": 97.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 142.0, 95.0, 145.0, 126.0, 82.0, 77.0, 152.0, 75.0, 147.0], "value": 118.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 66.0, 66.0, 67.0, 70.0, 67.0, 67.0, 67.0, 68.0, 68.0], "value": 67.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 62.0, 59.0, 60.0, 74.0, 65.0, 58.0, 52.0, 84.0, 84.0], "value": 65.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 110.0, 108.0, 76.0, 102.0, 109.0, 109.0, 85.0, 85.0, 108.0], "value": 99.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 153.0, 143.0, 150.0, 174.0, 158.0, 156.0, 140.0, 222.0, 141.0], "value": 159.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 188.0, 197.0, 202.0, 177.0, 186.0, 186.0, 182.0, 185.0, 187.0], "value": 187.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 70.0, 64.0, 66.0, 68.0, 70.0, 68.0, 66.0, 72.0], "value": 68.0, "unit": "score"}]}]} 11:38:42 INFO - Return code: 0 11:38:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:38:42 ERROR - # TBPL SUCCESS # 11:38:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:38:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:38:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:38:42 INFO - 2017-03-21 11:38:42.164 screenresolution[1671:10687] starting screenresolution argv=screenresolution get 11:38:42 INFO - 2017-03-21 11:38:42.166 screenresolution[1671:10687] Display 0: 1600x1200x32@60 11:38:42 INFO - 2017-03-21 11:38:42.172 screenresolution[1672:10690] starting screenresolution argv=screenresolution list 11:38:42 INFO - Available Modes on Display 0 11:38:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:38:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:38:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:38:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:38:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:38:42 INFO - Intel Iris: 11:38:42 INFO - Chipset Model: Intel Iris 11:38:42 INFO - Type: GPU 11:38:42 INFO - Bus: Built-In 11:38:42 INFO - VRAM (Dynamic, Max): 1536 MB 11:38:42 INFO - Vendor: Intel (0x8086) 11:38:42 INFO - Device ID: 0x0a2e 11:38:42 INFO - Revision ID: 0x0009 11:38:42 INFO - Displays: 11:38:42 INFO - Display: 11:38:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:38:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:38:42 INFO - Display Serial Number: 1600x1200 60 11:38:42 INFO - Main Display: Yes 11:38:42 INFO - Mirror: Off 11:38:42 INFO - Online: Yes 11:38:42 INFO - Rotation: Supported 11:38:42 INFO - Return code: 0 11:38:42 INFO - Running post-action listener: _resource_record_post_action 11:38:42 INFO - [mozharness: 2017-03-21 18:38:42.407008Z] Finished run-tests step (success) 11:38:42 INFO - Running post-run listener: _resource_record_post_run 11:38:42 INFO - Total resource usage - Wall time: 1200s; CPU: 54.0%; Read bytes: 41560576; Write bytes: 517388288; Read time: 406; Write time: 1650 11:38:42 INFO - TinderboxPrint: CPU usage
54.3% 11:38:42 INFO - TinderboxPrint: I/O read bytes / time
41,560,576 / 406 11:38:42 INFO - TinderboxPrint: I/O write bytes / time
517,388,288 / 1,650 11:38:42 INFO - TinderboxPrint: CPU idle
2,194.6 (45.7%) 11:38:42 INFO - TinderboxPrint: CPU system
967.2 (20.1%) 11:38:42 INFO - TinderboxPrint: CPU user
1,639.9 (34.2%) 11:38:42 INFO - TinderboxPrint: Swap in / out
250,298,368 / 0 11:38:42 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 206182912; Write bytes: 204642304; Read time: 15682; Write time: 490 11:38:42 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 39479808; Write bytes: 301932544; Read time: 382; Write time: 1126 11:38:42 INFO - Running post-run listener: _upload_blobber_files 11:38:42 INFO - Blob upload gear active. 11:38:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:38:42 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 11:38:42 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'] 11:38:42 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 11:38:43 INFO - (blobuploader) - INFO - Open directory for files ... 11:38:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:38:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:38:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:38:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:38:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:38:44 INFO - (blobuploader) - INFO - Done attempting. 11:38:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:38:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:38:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:38:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:38:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:38:45 INFO - (blobuploader) - INFO - Done attempting. 11:38:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:38:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:38:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:38:46 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:38:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:38:46 INFO - (blobuploader) - INFO - Done attempting. 11:38:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:38:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:38:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:38:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:38:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:38:49 INFO - (blobuploader) - INFO - Done attempting. 11:38:49 INFO - (blobuploader) - INFO - Iteration through files over. 11:38:49 INFO - Return code: 0 11:38:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:38:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:38:49 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6bc754087b8237c17e2b4126e5edcd2a8695b6a7d2d0aa66001a601aaae33d41326460d53fccd7d04862cf312d8cb3b5dc55c162260828c3a7f0bc47f94ced28", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3e6388e96e13840eb44c87f859b7aa56347c0a496845e4cbc6eee50ac105061d5a17e5caf2cbce416d04bb6c48f4b8dc30544e9cee98530deb26bd2bec8e178b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/69aba534a0a6121a2e2e5553aadaa6984812a1ca1b87a0069a99a3ae92987b92c87d9bfb2f59472b42cd2b15ecb70fadf4671871bc54b916574b1b2a963cc4cf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6c1751f68dfdb1d913af38ca7db4bb8a3a213c6a9d937e3b2babc71d04a92b2a0158366526ac57c7db41b5f72cb22573b145fc0917f9192787b16128e594d0cb"} 11:38:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:38:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:38:49 INFO - Contents: 11:38:49 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6bc754087b8237c17e2b4126e5edcd2a8695b6a7d2d0aa66001a601aaae33d41326460d53fccd7d04862cf312d8cb3b5dc55c162260828c3a7f0bc47f94ced28", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3e6388e96e13840eb44c87f859b7aa56347c0a496845e4cbc6eee50ac105061d5a17e5caf2cbce416d04bb6c48f4b8dc30544e9cee98530deb26bd2bec8e178b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/69aba534a0a6121a2e2e5553aadaa6984812a1ca1b87a0069a99a3ae92987b92c87d9bfb2f59472b42cd2b15ecb70fadf4671871bc54b916574b1b2a963cc4cf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6c1751f68dfdb1d913af38ca7db4bb8a3a213c6a9d937e3b2babc71d04a92b2a0158366526ac57c7db41b5f72cb22573b145fc0917f9192787b16128e594d0cb"} 11:38:49 INFO - Running post-run listener: copy_logs_to_upload_dir 11:38:49 INFO - Copying logs to upload dir... 11:38:49 INFO - mkdir: /builds/slave/test/build/upload/logs 11:38:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1283.974565 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-03-21 11:38:49.195899) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-21 11:38:49.199654) ========= 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.YFy4gx0Kd1/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.9h6eWAtNF2/Listeners TMPDIR=/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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/6bc754087b8237c17e2b4126e5edcd2a8695b6a7d2d0aa66001a601aaae33d41326460d53fccd7d04862cf312d8cb3b5dc55c162260828c3a7f0bc47f94ced28", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3e6388e96e13840eb44c87f859b7aa56347c0a496845e4cbc6eee50ac105061d5a17e5caf2cbce416d04bb6c48f4b8dc30544e9cee98530deb26bd2bec8e178b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/69aba534a0a6121a2e2e5553aadaa6984812a1ca1b87a0069a99a3ae92987b92c87d9bfb2f59472b42cd2b15ecb70fadf4671871bc54b916574b1b2a963cc4cf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6c1751f68dfdb1d913af38ca7db4bb8a3a213c6a9d937e3b2babc71d04a92b2a0158366526ac57c7db41b5f72cb22573b145fc0917f9192787b16128e594d0cb"} build_url:https://queue.taskcluster.net/v1/task/DpJ_0uuqQfyqN9k8ZTvquw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011432 build_url: 'https://queue.taskcluster.net/v1/task/DpJ_0uuqQfyqN9k8ZTvquw/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/6bc754087b8237c17e2b4126e5edcd2a8695b6a7d2d0aa66001a601aaae33d41326460d53fccd7d04862cf312d8cb3b5dc55c162260828c3a7f0bc47f94ced28", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3e6388e96e13840eb44c87f859b7aa56347c0a496845e4cbc6eee50ac105061d5a17e5caf2cbce416d04bb6c48f4b8dc30544e9cee98530deb26bd2bec8e178b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/69aba534a0a6121a2e2e5553aadaa6984812a1ca1b87a0069a99a3ae92987b92c87d9bfb2f59472b42cd2b15ecb70fadf4671871bc54b916574b1b2a963cc4cf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6c1751f68dfdb1d913af38ca7db4bb8a3a213c6a9d937e3b2babc71d04a92b2a0158366526ac57c7db41b5f72cb22573b145fc0917f9192787b16128e594d0cb"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-21 11:38:49.234656) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 11:38:49.234973) ========= 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.YFy4gx0Kd1/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.9h6eWAtNF2/Listeners TMPDIR=/var/folders/xg/002r27vj2cl62wmqwq6r5fgr00000w/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.005263 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 11:38:49.283150) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-21 11:38:49.283481) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-21 11:38:49.283808) ========= ========= Total master_lag: 0.18 =========