builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0087 starttime: 1493259982.96 results: success (0) buildid: 20170426173127 builduid: 946f85e2c58944838f5ebc085f21d0b2 revision: 0b77ed3f26c5335503bc16e85b8c067382e7bb1e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-26 19:26:22.965042) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-26 19:26:22.965521) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-26 19:26:22.965808) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-26 19:26:22.993015) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-26 19:26:22.993412) ========= 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.rXZ1VnZtE8/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.KVZ2zQzB5E/Listeners TMPDIR=/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-04-26 19:26: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% 166M=0s 2017-04-26 19:26:23 (166 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.152667 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-26 19:26:23.171090) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-26 19:26:23.171430) ========= 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.rXZ1VnZtE8/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.KVZ2zQzB5E/Listeners TMPDIR=/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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.030836 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-26 19:26:23.226328) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-26 19:26:23.226686) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0b77ed3f26c5335503bc16e85b8c067382e7bb1e --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 0b77ed3f26c5335503bc16e85b8c067382e7bb1e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.rXZ1VnZtE8/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.KVZ2zQzB5E/Listeners TMPDIR=/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-04-26 19:26:23,330 truncating revision to first 12 chars 2017-04-26 19:26:23,330 Setting DEBUG logging. 2017-04-26 19:26:23,330 attempt 1/10 2017-04-26 19:26:23,330 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0b77ed3f26c5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-26 19:26:24,363 unpacking tar archive at: mozilla-central-0b77ed3f26c5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.301681 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-26 19:26:24.552495) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-26 19:26:24.552827) ========= script_repo_revision: 0b77ed3f26c5335503bc16e85b8c067382e7bb1e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-26 19:26:24.553222) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-26 19:26:24.553512) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-26 19:26:24.573845) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-04-26 19:26:24.574175) ========= /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.rXZ1VnZtE8/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.KVZ2zQzB5E/Listeners TMPDIR=/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 19:26:24 INFO - MultiFileLogger online at 20170426 19:26:24 in /builds/slave/test 19:26:24 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 19:26:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:26:24 INFO - {'append_to_log': False, 19:26:24 INFO - 'base_work_dir': '/builds/slave/test', 19:26:24 INFO - 'blob_upload_branch': 'Firefox', 19:26:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:26:24 INFO - 'branch': 'Firefox', 19:26:24 INFO - 'buildbot_json_path': 'buildprops.json', 19:26:24 INFO - 'config_files': ('talos/mac_config.py',), 19:26:24 INFO - 'default_actions': ('clobber', 19:26:24 INFO - 'read-buildbot-config', 19:26:24 INFO - 'download-and-extract', 19:26:24 INFO - 'populate-webroot', 19:26:24 INFO - 'create-virtualenv', 19:26:24 INFO - 'install', 19:26:24 INFO - 'run-tests'), 19:26:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:26:24 INFO - 'download_minidump_stackwalk': True, 19:26:24 INFO - 'download_symbols': 'ondemand', 19:26:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:26:24 INFO - 'tooltool.py': '/tools/tooltool.py', 19:26:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:26:24 INFO - '/tools/misc-python/virtualenv.py')}, 19:26:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:26:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:26:24 INFO - 'gecko_profile': False, 19:26:24 INFO - 'gecko_profile_interval': 0, 19:26:24 INFO - 'installer_path': 'installer.exe', 19:26:24 INFO - 'log_level': 'info', 19:26:24 INFO - 'log_name': 'talos', 19:26:24 INFO - 'log_to_console': True, 19:26:24 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:26:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:26:24 INFO - 'opt_config_files': (), 19:26:24 INFO - 'pip_index': False, 19:26:24 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:26:24 INFO - 'cmd': ('bash', 19:26:24 INFO - '-c', 19:26:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:26:24 INFO - 'enabled': True, 19:26:24 INFO - 'halt_on_failure': False, 19:26:24 INFO - 'name': 'check_screen_resolution'},), 19:26:24 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:26:24 INFO - 'cmd': ('bash', 19:26:24 INFO - '-c', 19:26:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:26:24 INFO - 'enabled': True, 19:26:24 INFO - 'halt_on_failure': False, 19:26:24 INFO - 'name': 'check_screen_resolution'},), 19:26:24 INFO - 'run_cmd_checks_enabled': True, 19:26:24 INFO - 'suite': 'dromaeojs-e10s', 19:26:24 INFO - 'system_bits': '32', 19:26:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:26:24 INFO - 'title': 't-yosemite-r7-0087', 19:26:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:26:24 INFO - 'use_talos_json': True, 19:26:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:26:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:26:24 INFO - 'work_dir': 'build'} 19:26:24 INFO - [mozharness: 2017-04-27 02:26:24.786173Z] Running clobber step. 19:26:24 INFO - Running pre-action listener: _resource_record_pre_action 19:26:24 INFO - Running main action method: clobber 19:26:24 INFO - rmtree: /builds/slave/test/build 19:26:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:26:27 INFO - Running post-action listener: _resource_record_post_action 19:26:27 INFO - [mozharness: 2017-04-27 02:26:27.389930Z] Finished clobber step (success) 19:26:27 INFO - [mozharness: 2017-04-27 02:26:27.390062Z] Running read-buildbot-config step. 19:26:27 INFO - Running pre-action listener: _resource_record_pre_action 19:26:27 INFO - Running main action method: read_buildbot_config 19:26:27 INFO - Using buildbot properties: 19:26:27 INFO - { 19:26:27 INFO - "project": "", 19:26:27 INFO - "product": "firefox", 19:26:27 INFO - "script_repo_revision": "production", 19:26:27 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 19:26:27 INFO - "repository": "", 19:26:27 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 19:26:27 INFO - "buildid": "20170426173127", 19:26:27 INFO - "pgo_build": "False", 19:26:27 INFO - "basedir": "/builds/slave/test", 19:26:27 INFO - "buildnumber": 44, 19:26:27 INFO - "slavename": "t-yosemite-r7-0087", 19:26:27 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 19:26:27 INFO - "platform": "yosemite_r7", 19:26:27 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 19:26:27 INFO - "branch": "mozilla-central", 19:26:27 INFO - "repo_path": "mozilla-central", 19:26:27 INFO - "revision": "0b77ed3f26c5335503bc16e85b8c067382e7bb1e", 19:26:27 INFO - "stage_platform": "macosx64", 19:26:27 INFO - "builduid": "946f85e2c58944838f5ebc085f21d0b2", 19:26:27 INFO - "slavebuilddir": "test" 19:26:27 INFO - } 19:26:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/SPPAXnQGTfiYvz95qtdmLQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 19:26:27 INFO - Running post-action listener: _resource_record_post_action 19:26:27 INFO - [mozharness: 2017-04-27 02:26:27.393297Z] Finished read-buildbot-config step (success) 19:26:27 INFO - [mozharness: 2017-04-27 02:26:27.393434Z] Running download-and-extract step. 19:26:27 INFO - Running pre-action listener: _resource_record_pre_action 19:26:27 INFO - Running main action method: download_and_extract 19:26:27 INFO - mkdir: /builds/slave/test/build/tests 19:26:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:26:27 INFO - trying https://queue.taskcluster.net/v1/task/SPPAXnQGTfiYvz95qtdmLQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 19:26:27 INFO - Downloading https://queue.taskcluster.net/v1/task/SPPAXnQGTfiYvz95qtdmLQ/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 19:26:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SPPAXnQGTfiYvz95qtdmLQ/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 19:26:28 INFO - Downloaded 1325 bytes. 19:26:28 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 19:26:28 INFO - Using the following test package requirements: 19:26:28 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 19:26:28 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 19:26:28 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 19:26:28 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 19:26:28 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 19:26:28 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 19:26:28 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 19:26:28 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 19:26:28 INFO - u'jsshell-mac.zip'], 19:26:28 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 19:26:28 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 19:26:28 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 19:26:28 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 19:26:28 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 19:26:28 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 19:26:28 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 19:26:28 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 19:26:28 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 19:26:28 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 19:26:28 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 19:26:28 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 19:26:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SPPAXnQGTfiYvz95qtdmLQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 19:26:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SPPAXnQGTfiYvz95qtdmLQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:26:28 INFO - Fetch https://queue.taskcluster.net/v1/task/SPPAXnQGTfiYvz95qtdmLQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 19:26:30 INFO - Content-Length response header: 52531779 19:26:30 INFO - Bytes received: 52531779 19:26:46 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 19:26:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SPPAXnQGTfiYvz95qtdmLQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 19:26:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SPPAXnQGTfiYvz95qtdmLQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:26:46 INFO - Fetch https://queue.taskcluster.net/v1/task/SPPAXnQGTfiYvz95qtdmLQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 19:26:49 INFO - Content-Length response header: 52531779 19:26:49 INFO - Bytes received: 52531779 19:27:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SPPAXnQGTfiYvz95qtdmLQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 19:27:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SPPAXnQGTfiYvz95qtdmLQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 19:27:05 INFO - Fetch https://queue.taskcluster.net/v1/task/SPPAXnQGTfiYvz95qtdmLQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 19:27:06 INFO - Content-Length response header: 14408809 19:27:06 INFO - Bytes received: 14408809 19:27:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:06 INFO - trying https://queue.taskcluster.net/v1/task/SPPAXnQGTfiYvz95qtdmLQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 19:27:06 INFO - Downloading https://queue.taskcluster.net/v1/task/SPPAXnQGTfiYvz95qtdmLQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 19:27:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SPPAXnQGTfiYvz95qtdmLQ/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 19:27:08 INFO - Downloaded 71181475 bytes. 19:27:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SPPAXnQGTfiYvz95qtdmLQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 19:27:08 INFO - mkdir: /builds/slave/test/properties 19:27:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:27:08 INFO - Writing to file /builds/slave/test/properties/build_url 19:27:08 INFO - Contents: 19:27:08 INFO - build_url:https://queue.taskcluster.net/v1/task/SPPAXnQGTfiYvz95qtdmLQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 19:27:09 INFO - Running post-action listener: _resource_record_post_action 19:27:09 INFO - Running post-action listener: set_extra_try_arguments 19:27:09 INFO - [mozharness: 2017-04-27 02:27:09.676244Z] Finished download-and-extract step (success) 19:27:09 INFO - [mozharness: 2017-04-27 02:27:09.676371Z] Running populate-webroot step. 19:27:09 INFO - Running pre-action listener: _resource_record_pre_action 19:27:09 INFO - Running main action method: populate_webroot 19:27:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:27:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:27:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:27:09 INFO - '--tppagecycles', 19:27:09 INFO - '7'], 19:27:09 INFO - 'tests': ['tsvgm']}}, 19:27:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:27:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:27:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:27:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:27:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:27:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:27:09 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 19:27:09 INFO - 'talos_options': ['--disable-e10s'], 19:27:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:27:09 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:27:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:27:09 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 19:27:09 INFO - 'talos_options': ['--disable-e10s'], 19:27:09 INFO - 'tests': ['damp', 'tps']}, 19:27:09 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:27:09 INFO - 'tests': ['damp', 'tps']}, 19:27:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:27:09 INFO - 'tests': ['dromaeo_dom']}, 19:27:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:27:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:27:09 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 19:27:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 19:27:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:27:09 INFO - 'tests': ['a11yr', 19:27:09 INFO - 'ts_paint', 19:27:09 INFO - 'tpaint', 19:27:09 INFO - 'sessionrestore', 19:27:09 INFO - 'sessionrestore_no_auto_restore', 19:27:09 INFO - 'tabpaint']}, 19:27:09 INFO - 'other-e10s': {'tests': ['a11yr', 19:27:09 INFO - 'ts_paint', 19:27:09 INFO - 'tpaint', 19:27:09 INFO - 'sessionrestore', 19:27:09 INFO - 'sessionrestore_no_auto_restore', 19:27:09 INFO - 'tabpaint']}, 19:27:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:27:09 INFO - 'ts_paint', 19:27:09 INFO - 'tpaint', 19:27:09 INFO - 'sessionrestore', 19:27:09 INFO - 'sessionrestore_no_auto_restore', 19:27:09 INFO - 'tabpaint']}, 19:27:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:27:09 INFO - 'ts_paint', 19:27:09 INFO - 'tpaint', 19:27:09 INFO - 'sessionrestore', 19:27:09 INFO - 'sessionrestore_no_auto_restore', 19:27:09 INFO - 'tabpaint']}, 19:27:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:27:09 INFO - 'tests': ['a11yr', 19:27:09 INFO - 'ts_paint', 19:27:09 INFO - 'tpaint', 19:27:09 INFO - 'sessionrestore', 19:27:09 INFO - 'sessionrestore_no_auto_restore', 19:27:09 INFO - 'tabpaint']}, 19:27:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:27:09 INFO - 'tests': ['a11yr', 19:27:09 INFO - 'ts_paint', 19:27:09 INFO - 'tpaint', 19:27:09 INFO - 'sessionrestore', 19:27:09 INFO - 'sessionrestore_no_auto_restore', 19:27:09 INFO - 'tabpaint']}, 19:27:09 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 19:27:09 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 19:27:09 INFO - 'bloom_basic_ref']}, 19:27:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:27:09 INFO - 'tests': ['tsvgx', 19:27:09 INFO - 'tsvgr_opacity', 19:27:09 INFO - 'tart', 19:27:09 INFO - 'tscrollx', 19:27:09 INFO - 'cart', 19:27:09 INFO - 'tsvg_static']}, 19:27:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:27:09 INFO - 'tsvgr_opacity', 19:27:09 INFO - 'tart', 19:27:09 INFO - 'tscrollx', 19:27:09 INFO - 'cart', 19:27:09 INFO - 'tsvg_static']}, 19:27:09 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 19:27:09 INFO - 'talos_options': ['--disable-e10s'], 19:27:09 INFO - 'tests': ['tp5o']}, 19:27:09 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:27:09 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 19:27:09 INFO - 'talos_options': ['--disable-e10s', 19:27:09 INFO - '--xperf_path', 19:27:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:27:09 INFO - 'tests': ['tp5n']}, 19:27:09 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:27:09 INFO - 'talos_options': ['--xperf_path', 19:27:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:27:09 INFO - 'tests': ['tp5n']}}, 19:27:09 INFO - 'talos.zip': {'path': '', 19:27:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:27:09 INFO - Running post-action listener: _resource_record_post_action 19:27:09 INFO - [mozharness: 2017-04-27 02:27:09.695128Z] Finished populate-webroot step (success) 19:27:09 INFO - [mozharness: 2017-04-27 02:27:09.695259Z] Running create-virtualenv step. 19:27:09 INFO - Running pre-action listener: _resource_record_pre_action 19:27:09 INFO - Running main action method: create_virtualenv 19:27:09 INFO - Creating virtualenv /builds/slave/test/build/venv 19:27:09 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 19:27:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:27:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:27:09 INFO - Using real prefix '/tools/python27' 19:27:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:27:10 INFO - Installing distribute.............................................................................................................................................................................................done. 19:27:13 INFO - Installing pip.................done. 19:27:13 INFO - Return code: 0 19:27:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:27:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:27:13 INFO - Reading from file tmpfile_stdout 19:27:13 INFO - Output received: 19:27:13 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) 19:27:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:27:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106f8ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f8d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbabbca15f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d68d30>, '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 0x106c8edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106d5dbe8>, '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.rXZ1VnZtE8/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.KVZ2zQzB5E/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 19:27:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:27:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:27:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rXZ1VnZtE8/Render', 19:27:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:27:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:27:14 INFO - 'HOME': '/Users/cltbld', 19:27:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:27:14 INFO - 'LOGNAME': 'cltbld', 19:27:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:14 INFO - 'MOZ_NO_REMOTE': '1', 19:27:14 INFO - 'NO_EM_RESTART': '1', 19:27:14 INFO - 'PAGER': '/bin/cat', 19:27:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:27:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:14 INFO - 'PWD': '/builds/slave/test', 19:27:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:27:14 INFO - 'SHELL': '/bin/bash', 19:27:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KVZ2zQzB5E/Listeners', 19:27:14 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 19:27:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:27:14 INFO - 'USER': 'cltbld', 19:27:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:27:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:27:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:14 INFO - 'XPC_FLAGS': '0x0', 19:27:14 INFO - 'XPC_SERVICE_NAME': '0', 19:27:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:27:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:14 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 19:27:14 INFO - Cleaning up... 19:27:14 INFO - Return code: 0 19:27:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:27:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x106f8ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f8d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbabbca15f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d68d30>, '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 0x106c8edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106d5dbe8>, '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.rXZ1VnZtE8/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.KVZ2zQzB5E/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 19:27:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:27:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:27:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rXZ1VnZtE8/Render', 19:27:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:27:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:27:14 INFO - 'HOME': '/Users/cltbld', 19:27:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:27:14 INFO - 'LOGNAME': 'cltbld', 19:27:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:14 INFO - 'MOZ_NO_REMOTE': '1', 19:27:14 INFO - 'NO_EM_RESTART': '1', 19:27:14 INFO - 'PAGER': '/bin/cat', 19:27:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:27:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:14 INFO - 'PWD': '/builds/slave/test', 19:27:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:27:14 INFO - 'SHELL': '/bin/bash', 19:27:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KVZ2zQzB5E/Listeners', 19:27:14 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 19:27:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:27:14 INFO - 'USER': 'cltbld', 19:27:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:27:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:27:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:14 INFO - 'XPC_FLAGS': '0x0', 19:27:14 INFO - 'XPC_SERVICE_NAME': '0', 19:27:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:27:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:14 INFO - Downloading/unpacking psutil>=3.1.1 19:27:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:27:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:27:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:27:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:27:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:27:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:27:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:27:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:27:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:27:18 INFO - Installing collected packages: psutil 19:27:18 INFO - Running setup.py install for psutil 19:27:18 INFO - building 'psutil._psutil_osx' extension 19:27:18 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 19:27:19 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 19:27:19 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 19:27:19 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 19:27:19 INFO - building 'psutil._psutil_posix' extension 19:27:19 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 19:27:19 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:27:19 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:27:19 INFO - ^ 19:27:19 INFO - 1 warning generated. 19:27:19 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 19:27:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:27:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:27:19 INFO - Successfully installed psutil 19:27:19 INFO - Cleaning up... 19:27:20 INFO - Return code: 0 19:27:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:27:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106f8ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f8d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbabbca15f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d68d30>, '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 0x106c8edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106d5dbe8>, '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.rXZ1VnZtE8/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.KVZ2zQzB5E/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 19:27:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:27:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 19:27:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rXZ1VnZtE8/Render', 19:27:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:27:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:27:20 INFO - 'HOME': '/Users/cltbld', 19:27:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:27:20 INFO - 'LOGNAME': 'cltbld', 19:27:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:20 INFO - 'MOZ_NO_REMOTE': '1', 19:27:20 INFO - 'NO_EM_RESTART': '1', 19:27:20 INFO - 'PAGER': '/bin/cat', 19:27:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:27:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:20 INFO - 'PWD': '/builds/slave/test', 19:27:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:27:20 INFO - 'SHELL': '/bin/bash', 19:27:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KVZ2zQzB5E/Listeners', 19:27:20 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 19:27:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:27:20 INFO - 'USER': 'cltbld', 19:27:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:27:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:27:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:20 INFO - 'XPC_FLAGS': '0x0', 19:27:20 INFO - 'XPC_SERVICE_NAME': '0', 19:27:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:27:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:27:20 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 19:27:20 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 19:27:20 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 19:27:20 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 19:27:20 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 19:27:20 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 19:27:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:27:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:27:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:27:23 INFO - Installing collected packages: mozsystemmonitor 19:27:23 INFO - Running setup.py install for mozsystemmonitor 19:27:23 INFO - Successfully installed mozsystemmonitor 19:27:23 INFO - Cleaning up... 19:27:23 INFO - Return code: 0 19:27:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:27:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:23 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 0x106f8ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f8d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbabbca15f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d68d30>, '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 0x106c8edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106d5dbe8>, '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.rXZ1VnZtE8/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.KVZ2zQzB5E/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 19:27:23 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 19:27:23 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 19:27:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rXZ1VnZtE8/Render', 19:27:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:27:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:27:23 INFO - 'HOME': '/Users/cltbld', 19:27:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:27:23 INFO - 'LOGNAME': 'cltbld', 19:27:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:23 INFO - 'MOZ_NO_REMOTE': '1', 19:27:23 INFO - 'NO_EM_RESTART': '1', 19:27:23 INFO - 'PAGER': '/bin/cat', 19:27:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:27:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:23 INFO - 'PWD': '/builds/slave/test', 19:27:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:27:23 INFO - 'SHELL': '/bin/bash', 19:27:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KVZ2zQzB5E/Listeners', 19:27:23 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 19:27:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:27:23 INFO - 'USER': 'cltbld', 19:27:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:27:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:27:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:23 INFO - 'XPC_FLAGS': '0x0', 19:27:23 INFO - 'XPC_SERVICE_NAME': '0', 19:27:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:27:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:23 INFO - Downloading/unpacking jsonschema==2.5.1 19:27:23 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 19:27:23 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 19:27:23 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 19:27:23 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 19:27:23 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 19:27:23 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 19:27:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:27:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:27: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 19:27: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 19:27: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 19:27: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 19:27: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 19:27: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 19:27:26 INFO - Downloading functools32-3.2.3-2.tar.gz 19:27:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:27:26 INFO - warning: no files found matching '*.txt' 19:27:26 INFO - no previously-included directories found matching 'build' 19:27:26 INFO - no previously-included directories found matching 'dist' 19:27:26 INFO - no previously-included directories found matching '.git*' 19:27:26 INFO - Installing collected packages: jsonschema, functools32 19:27:26 INFO - Running setup.py install for functools32 19:27:26 INFO - warning: no files found matching '*.txt' 19:27:26 INFO - no previously-included directories found matching 'build' 19:27:26 INFO - no previously-included directories found matching 'dist' 19:27:26 INFO - no previously-included directories found matching '.git*' 19:27:26 INFO - Successfully installed jsonschema functools32 19:27:26 INFO - Cleaning up... 19:27:26 INFO - Return code: 0 19:27:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:27:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:27 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 0x106f8ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f8d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbabbca15f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d68d30>, '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 0x106c8edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106d5dbe8>, '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.rXZ1VnZtE8/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.KVZ2zQzB5E/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 19:27:27 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 19:27:27 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 19:27:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rXZ1VnZtE8/Render', 19:27:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:27:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:27:27 INFO - 'HOME': '/Users/cltbld', 19:27:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:27:27 INFO - 'LOGNAME': 'cltbld', 19:27:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:27 INFO - 'MOZ_NO_REMOTE': '1', 19:27:27 INFO - 'NO_EM_RESTART': '1', 19:27:27 INFO - 'PAGER': '/bin/cat', 19:27:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:27:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:27 INFO - 'PWD': '/builds/slave/test', 19:27:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:27:27 INFO - 'SHELL': '/bin/bash', 19:27:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KVZ2zQzB5E/Listeners', 19:27:27 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 19:27:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:27:27 INFO - 'USER': 'cltbld', 19:27:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:27:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:27:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:27 INFO - 'XPC_FLAGS': '0x0', 19:27:27 INFO - 'XPC_SERVICE_NAME': '0', 19:27:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:27:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:27:27 INFO - Cleaning up... 19:27:27 INFO - Return code: 0 19:27:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:27:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:27 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 0x106f8ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f8d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbabbca15f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d68d30>, '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 0x106c8edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106d5dbe8>, '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.rXZ1VnZtE8/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.KVZ2zQzB5E/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 19:27:27 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 19:27:27 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 19:27:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rXZ1VnZtE8/Render', 19:27:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:27:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:27:27 INFO - 'HOME': '/Users/cltbld', 19:27:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:27:27 INFO - 'LOGNAME': 'cltbld', 19:27:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:27 INFO - 'MOZ_NO_REMOTE': '1', 19:27:27 INFO - 'NO_EM_RESTART': '1', 19:27:27 INFO - 'PAGER': '/bin/cat', 19:27:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:27:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:27 INFO - 'PWD': '/builds/slave/test', 19:27:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:27:27 INFO - 'SHELL': '/bin/bash', 19:27:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KVZ2zQzB5E/Listeners', 19:27:27 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 19:27:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:27:27 INFO - 'USER': 'cltbld', 19:27:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:27:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:27:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:27 INFO - 'XPC_FLAGS': '0x0', 19:27:27 INFO - 'XPC_SERVICE_NAME': '0', 19:27:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:27:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:27 INFO - Downloading/unpacking blobuploader==1.2.4 19:27:27 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 19:27:27 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 19:27:27 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 19:27:27 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 19:27:27 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 19:27:27 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 19:27:30 INFO - Downloading blobuploader-1.2.4.tar.gz 19:27:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:27:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:27:30 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 19:27:30 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 19:27:30 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 19:27:30 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 19:27:30 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 19:27:30 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 19:27:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:27:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:27:30 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 19:27:30 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 19:27:30 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 19:27:30 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 19:27:30 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 19:27:30 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 19:27:31 INFO - Downloading docopt-0.6.1.tar.gz 19:27:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:27:31 INFO - Installing collected packages: blobuploader, requests, docopt 19:27:31 INFO - Running setup.py install for blobuploader 19:27:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:27:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:27:31 INFO - Running setup.py install for requests 19:27:32 INFO - Running setup.py install for docopt 19:27:32 INFO - Successfully installed blobuploader requests docopt 19:27:32 INFO - Cleaning up... 19:27:32 INFO - Return code: 0 19:27:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:27:32 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')]} 19:27:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:32 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')]} 19:27:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:32 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 0x106f8ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f8d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbabbca15f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d68d30>, '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 0x106c8edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106d5dbe8>, '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.rXZ1VnZtE8/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.KVZ2zQzB5E/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 19:27:32 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 19:27:32 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 19:27:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rXZ1VnZtE8/Render', 19:27:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:27:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:27:32 INFO - 'HOME': '/Users/cltbld', 19:27:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:27:32 INFO - 'LOGNAME': 'cltbld', 19:27:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:32 INFO - 'MOZ_NO_REMOTE': '1', 19:27:32 INFO - 'NO_EM_RESTART': '1', 19:27:32 INFO - 'PAGER': '/bin/cat', 19:27:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:27:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:32 INFO - 'PWD': '/builds/slave/test', 19:27:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:27:32 INFO - 'SHELL': '/bin/bash', 19:27:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KVZ2zQzB5E/Listeners', 19:27:32 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 19:27:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:27:32 INFO - 'USER': 'cltbld', 19:27:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:27:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:27:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:32 INFO - 'XPC_FLAGS': '0x0', 19:27:32 INFO - 'XPC_SERVICE_NAME': '0', 19:27:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:27:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:27:32 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-_nil76-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:27:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:27:32 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-kHSdId-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:27:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:27:32 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-JR4Gun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:27:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:27:33 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-yorNsp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:27:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:27:33 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-zfU7ak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:27:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:27:33 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-iTZtC2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:27:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:27:33 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-b6P6nK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:27:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:27:33 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-adiKeF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:27:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:27:33 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-10yynY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:27:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:27:33 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-7xIPk7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:27:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:27:33 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-nyntEX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:27:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:27:33 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-ATNDq1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:27:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:27:33 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-7MshpT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:27:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:27:34 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-KpW_mi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:27:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:27:34 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-cCiUAe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:27:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:27:34 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-ZemYRN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:27:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:27:34 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-FcmsT_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:27:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:27:34 INFO - Running setup.py install for manifestparser 19:27:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:27:34 INFO - Running setup.py install for mozcrash 19:27:34 INFO - Running setup.py install for mozdebug 19:27:34 INFO - Running setup.py install for mozdevice 19:27:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:27:35 INFO - Running setup.py install for mozfile 19:27:35 INFO - Running setup.py install for mozhttpd 19:27:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:27:35 INFO - Running setup.py install for mozinfo 19:27:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:27:35 INFO - Running setup.py install for mozInstall 19:27:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:27:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:27:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:27:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:27:35 INFO - Running setup.py install for mozleak 19:27:35 INFO - Running setup.py install for mozlog 19:27:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:27:35 INFO - Running setup.py install for moznetwork 19:27:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:27:36 INFO - Running setup.py install for mozprocess 19:27:36 INFO - Running setup.py install for mozprofile 19:27:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:27:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:27:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:27:36 INFO - Running setup.py install for mozrunner 19:27:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:27:36 INFO - Running setup.py install for mozscreenshot 19:27:36 INFO - Running setup.py install for moztest 19:27:36 INFO - Running setup.py install for mozversion 19:27:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:27:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:27:37 INFO - Cleaning up... 19:27:37 INFO - Return code: 0 19:27:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:27:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:37 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 0x106f8ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f8d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbabbca15f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d68d30>, '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 0x106c8edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106d5dbe8>, '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.rXZ1VnZtE8/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.KVZ2zQzB5E/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 19:27:37 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 19:27:37 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 19:27:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rXZ1VnZtE8/Render', 19:27:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:27:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:27:37 INFO - 'HOME': '/Users/cltbld', 19:27:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:27:37 INFO - 'LOGNAME': 'cltbld', 19:27:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:37 INFO - 'MOZ_NO_REMOTE': '1', 19:27:37 INFO - 'NO_EM_RESTART': '1', 19:27:37 INFO - 'PAGER': '/bin/cat', 19:27:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:27:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:37 INFO - 'PWD': '/builds/slave/test', 19:27:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:27:37 INFO - 'SHELL': '/bin/bash', 19:27:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KVZ2zQzB5E/Listeners', 19:27:37 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 19:27:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:27:37 INFO - 'USER': 'cltbld', 19:27:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:27:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:27:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:37 INFO - 'XPC_FLAGS': '0x0', 19:27:37 INFO - 'XPC_SERVICE_NAME': '0', 19:27:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:27:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:27:37 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-diX_4A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:27:37 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)) 19:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:27:37 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-XHwAun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:27:37 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)) 19:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:27:37 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-7eccX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:27:37 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)) 19:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:27:37 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-TIcpJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:27:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:27:37 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-HjDThg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:27:37 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)) 19:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:27:37 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-rWZrtZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:27:37 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)) 19:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:27:37 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-t9WXrP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:27:38 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)) 19:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:27:38 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-2q7_qg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:27:38 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)) 19:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:27:38 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-JIYwC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:27:38 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)) 19:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:27:38 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-OCxHCZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:27:38 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)) 19:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:27:38 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-mpPIYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:27:38 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)) 19:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:27:38 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-pC_Rsu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:27:38 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)) 19:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:27:38 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-qPDuIm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:27:38 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)) 19:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:27:38 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-XRi4XM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:27:38 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)) 19:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:27:38 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-PKTR4B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:27:38 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)) 19:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:27:38 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-JNVlTs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:27:38 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)) 19:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:27:39 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-DgqASH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:27:39 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)) 19:27:39 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)) 19:27:39 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)) 19:27:39 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)) 19:27:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:27:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:27:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:27:39 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 19:27:39 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 19:27:39 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 19:27:39 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 19:27:39 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 19:27:39 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 19:27:41 INFO - Downloading blessings-1.6.tar.gz 19:27:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:27:41 INFO - Installing collected packages: blessings 19:27:41 INFO - Running setup.py install for blessings 19:27:42 INFO - Successfully installed blessings 19:27:42 INFO - Cleaning up... 19:27:42 INFO - Return code: 0 19:27:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:27:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:27:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:27:42 INFO - Reading from file tmpfile_stdout 19:27:42 INFO - Current package versions: 19:27:42 INFO - blessings == 1.6 19:27:42 INFO - blobuploader == 1.2.4 19:27:42 INFO - docopt == 0.6.1 19:27:42 INFO - functools32 == 3.2.3-2 19:27:42 INFO - jsonschema == 2.5.1 19:27:42 INFO - manifestparser == 1.1 19:27:42 INFO - mozInstall == 1.12 19:27:42 INFO - mozcrash == 1.0 19:27:42 INFO - mozdebug == 0.1 19:27:42 INFO - mozdevice == 0.50 19:27:42 INFO - mozfile == 1.2 19:27:42 INFO - mozhttpd == 0.7 19:27:42 INFO - mozinfo == 0.9 19:27:42 INFO - mozleak == 0.1 19:27:42 INFO - mozlog == 3.4 19:27:42 INFO - moznetwork == 0.27 19:27:42 INFO - mozprocess == 0.25 19:27:42 INFO - mozprofile == 0.28 19:27:42 INFO - mozrunner == 6.13 19:27:42 INFO - mozscreenshot == 0.1 19:27:42 INFO - mozsystemmonitor == 0.3 19:27:42 INFO - moztest == 0.8 19:27:42 INFO - mozversion == 1.4 19:27:42 INFO - psutil == 3.1.1 19:27:42 INFO - requests == 1.2.3 19:27:42 INFO - wsgiref == 0.1.2 19:27:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:27:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:42 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 0x106f8ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f8d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbabbca15f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d68d30>, '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 0x106c8edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106d5dbe8>, '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.rXZ1VnZtE8/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.KVZ2zQzB5E/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 19:27:42 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 19:27:42 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 19:27:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rXZ1VnZtE8/Render', 19:27:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:27:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:27:42 INFO - 'HOME': '/Users/cltbld', 19:27:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:27:42 INFO - 'LOGNAME': 'cltbld', 19:27:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:42 INFO - 'MOZ_NO_REMOTE': '1', 19:27:42 INFO - 'NO_EM_RESTART': '1', 19:27:42 INFO - 'PAGER': '/bin/cat', 19:27:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:27:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:42 INFO - 'PWD': '/builds/slave/test', 19:27:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:27:42 INFO - 'SHELL': '/bin/bash', 19:27:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KVZ2zQzB5E/Listeners', 19:27:42 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 19:27:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:27:42 INFO - 'USER': 'cltbld', 19:27:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:27:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:27:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:42 INFO - 'XPC_FLAGS': '0x0', 19:27:42 INFO - 'XPC_SERVICE_NAME': '0', 19:27:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:27:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:42 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)) 19:27:42 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)) 19:27:42 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)) 19:27:42 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)) 19:27:42 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)) 19:27:42 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)) 19:27:42 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)) 19:27:42 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)) 19:27:42 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)) 19:27:42 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)) 19:27:42 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)) 19:27:42 INFO - Cleaning up... 19:27:42 INFO - Return code: 0 19:27:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:27:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:42 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 0x106f8ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f8d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbabbca15f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d68d30>, '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 0x106c8edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106d5dbe8>, '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.rXZ1VnZtE8/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.KVZ2zQzB5E/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 19:27:42 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 19:27:42 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 19:27:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rXZ1VnZtE8/Render', 19:27:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:27:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:27:42 INFO - 'HOME': '/Users/cltbld', 19:27:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:27:42 INFO - 'LOGNAME': 'cltbld', 19:27:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:42 INFO - 'MOZ_NO_REMOTE': '1', 19:27:42 INFO - 'NO_EM_RESTART': '1', 19:27:42 INFO - 'PAGER': '/bin/cat', 19:27:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:27:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:42 INFO - 'PWD': '/builds/slave/test', 19:27:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:27:42 INFO - 'SHELL': '/bin/bash', 19:27:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KVZ2zQzB5E/Listeners', 19:27:42 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 19:27:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:27:42 INFO - 'USER': 'cltbld', 19:27:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:27:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:27:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:42 INFO - 'XPC_FLAGS': '0x0', 19:27:42 INFO - 'XPC_SERVICE_NAME': '0', 19:27:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:27:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:27:42 INFO - Cleaning up... 19:27:42 INFO - Return code: 0 19:27:42 INFO - Running post-action listener: _resource_record_post_action 19:27:42 INFO - Running post-action listener: _start_resource_monitoring 19:27:42 INFO - Starting resource monitoring. 19:27:42 INFO - [mozharness: 2017-04-27 02:27:42.993031Z] Finished create-virtualenv step (success) 19:27:42 INFO - [mozharness: 2017-04-27 02:27:42.993992Z] Running install step. 19:27:42 INFO - Running pre-action listener: _resource_record_pre_action 19:27:42 INFO - Running main action method: install 19:27:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:27:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:27:43 INFO - Reading from file tmpfile_stdout 19:27:43 INFO - Detecting whether we're running mozinstall >=1.0... 19:27:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:27:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:27:43 INFO - Reading from file tmpfile_stdout 19:27:43 INFO - Output received: 19:27:43 INFO - Usage: mozinstall [options] installer 19:27:43 INFO - Options: 19:27:43 INFO - -h, --help show this help message and exit 19:27:43 INFO - -d DEST, --destination=DEST 19:27:43 INFO - Directory to install application into. [default: 19:27:43 INFO - "/builds/slave/test"] 19:27:43 INFO - --app=APP Application being installed. [default: firefox] 19:27:43 INFO - mkdir: /builds/slave/test/build/application 19:27:43 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'] 19:27:43 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 19:28:03 INFO - Reading from file tmpfile_stdout 19:28:03 INFO - Output received: 19:28:03 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 19:28:03 INFO - Running post-action listener: _resource_record_post_action 19:28:03 INFO - [mozharness: 2017-04-27 02:28:03.397020Z] Finished install step (success) 19:28:03 INFO - [mozharness: 2017-04-27 02:28:03.397163Z] Running run-tests step. 19:28:03 INFO - Running pre-action listener: _resource_record_pre_action 19:28:03 INFO - Running main action method: run_tests 19:28:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:28:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:28:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:28:03 INFO - 2017-04-26 19:28:03.411 screenresolution[1625:7804] starting screenresolution argv=screenresolution get 19:28:03 INFO - 2017-04-26 19:28:03.414 screenresolution[1625:7804] Display 0: 1600x1200x32@60 19:28:03 INFO - 2017-04-26 19:28:03.420 screenresolution[1626:7806] starting screenresolution argv=screenresolution list 19:28:03 INFO - Available Modes on Display 0 19:28:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:28:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:28:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:28:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:28:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:28:03 INFO - Intel Iris: 19:28:03 INFO - Chipset Model: Intel Iris 19:28:03 INFO - Type: GPU 19:28:03 INFO - Bus: Built-In 19:28:03 INFO - VRAM (Dynamic, Max): 1536 MB 19:28:03 INFO - Vendor: Intel (0x8086) 19:28:03 INFO - Device ID: 0x0a2e 19:28:03 INFO - Revision ID: 0x0009 19:28:03 INFO - Displays: 19:28:03 INFO - Display: 19:28:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:28:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:28:03 INFO - Display Serial Number: 1600x1200 60 19:28:03 INFO - Main Display: Yes 19:28:03 INFO - Mirror: Off 19:28:03 INFO - Online: Yes 19:28:03 INFO - Rotation: Supported 19:28:03 INFO - Return code: 0 19:28:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:28:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:28:03 INFO - Python 2.7.3 19:28:03 INFO - Return code: 0 19:28:03 INFO - grabbing minidump binary from tooltool 19:28:03 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')]} 19:28:03 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 0x106d68d30>, '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 0x106c8edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106d5dbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:28:03 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 19:28:03 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 19:28:03 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 19:28:03 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:28:03 INFO - Return code: 0 19:28:03 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:28:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:28:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:28:03 INFO - ENV: RUST_BACKTRACE is now 1 19:28:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:28:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:28:03 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/SPPAXnQGTfiYvz95qtdmLQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0087', '--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 19:28:03 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/SPPAXnQGTfiYvz95qtdmLQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0087 --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 19:28:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rXZ1VnZtE8/Render', 19:28:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:28:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:28:03 INFO - 'HOME': '/Users/cltbld', 19:28:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:28:03 INFO - 'LOGNAME': 'cltbld', 19:28:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:28:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:28:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:28:03 INFO - 'MOZ_NO_REMOTE': '1', 19:28:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:28:03 INFO - 'NO_EM_RESTART': '1', 19:28:03 INFO - 'PAGER': '/bin/cat', 19:28:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:28:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:28:03 INFO - 'PWD': '/builds/slave/test', 19:28:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:28:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:28:03 INFO - 'RUST_BACKTRACE': '1', 19:28:03 INFO - 'SHELL': '/bin/bash', 19:28:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KVZ2zQzB5E/Listeners', 19:28:03 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 19:28:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:28:03 INFO - 'USER': 'cltbld', 19:28:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:28:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:28:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:28:03 INFO - 'XPC_FLAGS': '0x0', 19:28:03 INFO - 'XPC_SERVICE_NAME': '0', 19:28:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:28:03 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/SPPAXnQGTfiYvz95qtdmLQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0087', '--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 19:28:04 INFO - mozversion application_buildid: 20170426173127 19:28:04 INFO - mozversion application_changeset: 0b77ed3f26c5335503bc16e85b8c067382e7bb1e 19:28:04 INFO - mozversion application_display_name: Nightly 19:28:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:28:04 INFO - mozversion application_name: Firefox 19:28:04 INFO - mozversion application_remotingname: firefox 19:28:04 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:28:04 INFO - mozversion application_vendor: Mozilla 19:28:04 INFO - mozversion application_version: 55.0a1 19:28:04 INFO - mozversion platform_buildid: 20170426173127 19:28:04 INFO - mozversion platform_changeset: 0b77ed3f26c5335503bc16e85b8c067382e7bb1e 19:28:04 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:28:04 INFO - mozversion platform_version: 55.0a1 19:28:04 INFO - using testdate: 1493260084 19:28:04 INFO - actual date: 1493260084 19:28:04 INFO - starting webserver on 'localhost:49240' 19:28:04 INFO - SUITE-START | Running 2 tests 19:28:04 INFO - TEST-START | dromaeo_css 19:28:04 INFO - operating with platform_type : mac_ 19:28:04 INFO - Initialising browser for dromaeo_css test... 19:28:04 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/tmpgQsVF8/profile http://localhost:49240/getInfo.html) 19:28:06 INFO - PID 1636 | 2017-04-26 19:28:06.844 plugin-container[1638:7974] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x983f, name = 'com.apple.tsm.portname' 19:28:06 INFO - PID 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:28:06 INFO - PID 1636 | 2017-04-26 19:28:06.846 plugin-container[1638:7974] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4917, name = 'com.apple.CFPasteboardClient' 19:28:06 INFO - PID 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:28:06 INFO - PID 1636 | 2017-04-26 19:28:06.846 plugin-container[1638:7974] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 19:28:06 INFO - PID 1636 | __metrics Screen width/height:1600/1200 19:28:06 INFO - PID 1636 | colorDepth:24 19:28:06 INFO - PID 1636 | Browser inner width/height: 1024/689 19:28:06 INFO - PID 1636 | __metrics 19:28:07 ERROR - PID 1636 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3424: TypeError: this.tabs is undefined 19:28:07 INFO - TEST-INFO | 1636: exit 0 19:28:07 INFO - Browser initialized. 19:28:07 INFO - Running cycle 1/1 for dromaeo_css test... 19:28:07 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/tmpgQsVF8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:28:10 INFO - PID 1639 | 2017-04-26 19:28:10.236 plugin-container[1640:8100] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4547, name = 'com.apple.tsm.portname' 19:28:10 INFO - PID 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:28:10 INFO - PID 1639 | 2017-04-26 19:28:10.236 plugin-container[1640:8100] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x481b, name = 'com.apple.CFPasteboardClient' 19:28:10 INFO - PID 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:28:10 INFO - PID 1639 | 2017-04-26 19:28:10.236 plugin-container[1640:8100] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 19:28:20 INFO - PID 1639 | RSS: Main: 235835392 19:28:20 INFO - PID 1639 | 19:31:24 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49240/tests/dromaeo/cssquery-ext.html) 19:31:26 INFO - PID 1639 | RSS: Main: 252551168 19:31:26 INFO - PID 1639 | 19:33:08 INFO - PID 1639 | ************************* 19:33:08 INFO - PID 1639 | A coding exception was thrown and uncaught in a Task. 19:33:08 INFO - PID 1639 | 19:33:08 ERROR - PID 1639 | Full message: TypeError: NetworkError when attempting to fetch resource. 19:33:08 INFO - PID 1639 | Full stack: 19:33:08 INFO - PID 1639 | ************************* 19:33:08 INFO - PID 1639 | ************************* 19:33:08 INFO - PID 1639 | A coding exception was thrown and uncaught in a Task. 19:33:08 INFO - PID 1639 | 19:33:08 ERROR - PID 1639 | Full message: TypeError: NetworkError when attempting to fetch resource. 19:33:08 INFO - PID 1639 | Full stack: 19:33:08 INFO - PID 1639 | ************************* 19:33:08 INFO - PID 1639 | ************************* 19:33:08 INFO - PID 1639 | A coding exception was thrown and uncaught in a Task. 19:33:08 INFO - PID 1639 | 19:33:08 ERROR - PID 1639 | Full message: TypeError: NetworkError when attempting to fetch resource. 19:33:08 INFO - PID 1639 | Full stack: 19:33:08 INFO - PID 1639 | ************************* 19:33:08 INFO - PID 1639 | ************************* 19:33:08 INFO - PID 1639 | A coding exception was thrown and uncaught in a Task. 19:33:08 INFO - PID 1639 | 19:33:08 ERROR - PID 1639 | Full message: TypeError: NetworkError when attempting to fetch resource. 19:33:08 INFO - PID 1639 | Full stack: 19:33:08 INFO - PID 1639 | ************************* 19:34:28 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-ext.html (next: http://localhost:49240/tests/dromaeo/cssquery-jquery.html) 19:34:28 INFO - PID 1639 | RSS: Main: 257224704 19:34:28 INFO - PID 1639 | 19:37:30 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49240/tests/dromaeo/cssquery-mootools.html) 19:37:31 INFO - PID 1639 | RSS: Main: 267120640 19:37:31 INFO - PID 1639 | 19:40:33 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49240/tests/dromaeo/cssquery-prototype.html) 19:40:33 INFO - PID 1639 | RSS: Main: 261083136 19:40:33 INFO - PID 1639 | 19:43:36 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49240/tests/dromaeo/cssquery-yui.html) 19:43:37 INFO - PID 1639 | RSS: Main: 270217216 19:43:37 INFO - PID 1639 | 19:46:39 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-yui.html (next: http://localhost:49240/tests/dromaeo/cssquery-dojo.html) 19:46:39 INFO - PID 1639 | RSS: Main: 264830976 19:46:39 INFO - PID 1639 | 19:46:39 INFO - PID 1639 | __start_tp_report 19:46:39 INFO - PID 1639 | _x_x_mozilla_page_load 19:46:39 INFO - PID 1639 | _x_x_mozilla_page_load_details 19:46:39 INFO - PID 1639 | |i|pagename|runs| 19:46:39 INFO - PID 1639 | |0;dojo.html;3567.161716996505;3618.40296351102;3626.854925802968;3634.927301453971;3640.7087433005354;5212.609054320927;6091.177691011712;6100.511959043277;6122.204113465249;6226.501879849612;6167.691615419233;6181.845453863656;6218.4092511211475;6248.812535623939;6296.181496405461;5392.1911713243135;5421.9457805421835;5445.455454454563;5459.836204913859;5465.879494703586;4949.480304568023;5557.916631250535;5580;5585.804496842611;5619.297587801525;5390.272313237702;5391.083515802323;5400;5493.368262649807;5513.117901135799;5481.451854814526;5496.6701997880255;5542.11326187812;5574.9721251393885;5598.944010559883;5423.755930983115;5470.91793623096;5472.91790623141;5475.7262136893;5494.697791621459;6094.725737341831;6295.527835412317;6309.495240380758;6318.526110541682;6321.87356252877;6416.422521973045;6522;6604.537682362236;6703.698333575001;6705.396514313687;6826.078479405266;6826.317368263183;6829.6243706596115;6833.931660683379;6867.313268673142;6266.592671476339;6287.465565426898;6332.176817013851;6332.271788744308;6336.746530138835;6684.966575167093;6807.319268073252;6936.722531098801;6991.7902462926195;6994.300569943067;6336.778212762623;6402.9359706403275;6557.180352455943;6571.80284591463;6689.565178263398;6802.523823332418;6814.557053791487;6858.108445902001;6877.346652068046;6886.48351373649;6755.932440675629;6765.932340676629;6769.32306769329;6777.932220677829;6790.219124800612;5412.56699464042;6448.419642232222;6677.23211830636;6743;6786.76246331376;5336.7865285388925;5372.946270537244;5374.247605335257;5375.435579264199;5377.569794416438;4629.629629629621;4783.258594917794;4787.210110331756;4799.3041009053495;4806.855794326176;6112.419320164578;6194.194754681863;6451.161349024596;6455.7740479083;6464.159659244268;6623.4701223901975;6755.256921738604;6770.4922130839395;6868.862622747517;6877.965610171917;6392.680365981682;6398.488120950313;6407.7436902524305;6409.038644203313;6414.583052101599;5099;5946.1972633693895;5963.73163207648;5966.403359664086;6008.09878518217;6677.933220667731;6767.120274364301;6861.897071544031;6942.51402401827;7006.229314775473;6739.797806065826;6748.358905903931;6763.7632682855865;6799.252082271045;6812.591244525344;6864.176298844171;6942.895856562257;6944.51388402807;6946.340097690711;6946.79159625212;6426.485881129592;6505;6658.167729033871;6671.066050752996;6672.6997285121315;6606.867862642816;6816.318368163144;6830.112085428863;6856;6857.828554285983;6306.779262725782;6367.777127800505;6645.3022432643875;6664.333566643297;6673.532852700265;6455.4512866406885;6551.639659818756;6559.8032059038305;6563.212414510289;6589.077529145828;6216.378362163748;6458.612483250832;6519.7392104315295;6527.5430719849155;6533.967330163318;6412.839679008062;6426.839329016812;6554.508411869034;6566.606003639797;6591.571547849375;6472.546921715623;6475.870482590228;6478.3197764235965;6486.481081513373;6489.448396886129 19:46:39 INFO - PID 1639 | |1;ext.html;739.7313607163717;805.1103530598689;826.8919647672118;1001.959921603136;1201.4173126033872;36483.817580912095;37180.442293365624;37198.512059517656;37263.254734905284;37266.06834829131;36897;36939;37174.88475345737;37273.62726372736;37287;7790.532568045921;8182.590870456484;8425.747227583182;8476.618552165168;8490;8387.580620968927;8515.063343032261;8523.57382130891;8529.445586036887;8556.315494760403;8456.154384561556;8525.786855328604;8526.57367131644;8540.188682075193;8577.914220857805;7212.2427145149795;8398.622062007194;8492.53291068991;8527.488350698977;8532.061473237938;8304;8318.875216871751;8352.83294334116;8358.83282334356;8367.874481882776;36119.81940090309;36217.63782362169;36254.09364765875;36295.4555681665;36380;3628.838771593091;3669.4495825626104;3683.0976410779263;3683.797391143486;3684.7420680552373;30348.241293967607;30413.08760737159;30484.93302734416;30503.69496305053;30576.08271751851;3052.862621182052;3102.5811515445575;3106.7203951644233;3118.7504999600205;3125.828079455629;242899;245616.54383456116;264299;303493;303669;37591.62408375881;38874.416883746766;39210.62762803345;45465.77267113643;45468;45070.647880563636;47664.42516811253;47878.366689831695;47885.76057119692;47923;14081.647958800908;14119.364628591738;14222.2177780221;14225.14649121056;14237.50168744089;9930.404175749478;11567.537298508134;11641.185117041896;11645.475953582109;11653.53385864573;12053.397330133459;12588.496460141492;13135.934320328337;13204.405801738752;13388.464461421629;5903.468687818117;5952.345242023374;5979.491743201789;6014.6391216527145;6015.4586087252355;1021.9897801021895;1026.7176526455285;1042.4318746283143;1066.3495267886583;1078.724925144099;22877.31368058961;23884;24085.33237499136;24164.758352416604;24413.877930610233;1001.7545701303227;1135.784201001807;1146.7763786061805;1177.0465922602718;1182.798924182891;10324;11855.05159587231;12222.083343749255;12241.571544995883;12276.202046866925;330801;331952;333467;333747;334173;52025.7398713004;52036.21945670818;52223.95552089013;52294;52358.16746413857;1493.9701205975819;1525.4889611979888;1559.9220038998005;1561.375449820081;1585.1519437101097;19197;19983.469099165628;23516;23673.881630591735;24075.638865417382;36738.8163059183;47403.525964739914;48480.51519484901;48506.02987940292;48709;260484;260700;261302;261609;262042;32142.83928580342;32177.678223217466;33516.329673406886;33688.83155584305;33733.81931632381;41987;42777;44412.55587444084;44556.886077848314;44695;26842.597361039992;29618.703812961594;30356.089317320515;30587.847060764554;30923.226919327197;30589.23526911756;30682.84658576693;30687.846560767055;30722.692773071984;30776.922807701623;36886.44670330001;37029;37041.62958370382;37172.81413593023;37249.44125838169;26804.463910722065;29213.269668258465;30472;30804;30843.383132337676;22312.330630081124;23873.045078197374;23985;24328.27015189547;24564.140255090984 19:46:39 INFO - PID 1639 | |2;jquery.html;382.42445120094254;423.5489203997742;423.79022383919965;436.31280732845767;436.60923473491226;21141.68287475689;21403.35789926303;22058.897055147238;22547;22691.20580779669;22158;22677.86610669464;22701;22886.230643684565;23004.079836806548;5364.785408583672;5968.5523585731025;6204.100405441209;6208.317085120633;6211.968940155293;5854.5023672987845;6100.694965251741;6167.537434692394;6172.135900973867;6180.165677633529;5916.970415147918;6076.392360763933;6122.6632535210765;6124.6631435271265;6130.938690613104;5953.196318496991;6084.056971169476;6103.603265787754;6120.755169793203;6128.1114238435175;5281.52466278033;5355.866103347408;5376.596755243333;5430.456954304538;5455.536279416255;26422.339441514116;26538.86730566335;26635;26740.8662956684;26809.597856032175;2223.855449395784;2295.414669259328;2295.5294164696197;2296.196331284037;2299.954000919989;15725.685486290324;17454.214560344815;17925.64148717018;17955;18024;2188.6607575825774;2196.8352373572047;2218.7004754358118;2219.4784225706944;2224.73303203615;167721;168305;168608.99999999878;171403.1429842855;171659;10697.786044279072;12755.043371747157;12800.423980920881;13079.607611771662;13168.73662526744;16586.336546538245;16752.58118547022;16789.992600444013;16792.83207167937;16797.244124014447;8685.632118815496;8981.14679105484;9025.864612030824;9079.45523268606;9112.95443522778;8431.367647426467;8443.197896199852;8454.61954212062;8591.5704214789;8636.352273579507;7933.404994625311;7970;8012.719554815553;8017.879731804028;8059.838803223903;2206.9889650551645;2210.7789221077765;2212.104097840377;2213.8339624528226;2376.4534157143607;973.868527748759;981.955811988448;998.1765043838717;1001.9849702254472;1033.235405799703;20393.98030098489;21066.2626808061;21325.253616123362;25631.48737025249;27374.72625273722;1019.4444028004755;1020.321486211661;1026.9640562580273;1049.3074570783247;1052.9736756580994;10747.193960452998;11153;11215.71960700989;11255.774884502263;11296.887031129749;556788;560545;561671;570687;572706;132101;134271;134440;137081;139695;1207.9214851034656;1236.2150034727833;1264.6775072356675;1271.8855303022588;1275.5471807508386;21982.230621928156;23145.726985015986;23161.3051608452;23291.71895545761;23322;58213.126803098836;58796;59160;59169;59747.701261493414;78740;81261;81887.18112818795;83347;83727;8632.956835216035;8762.123787621442;8915.37592368528;8944.910550894409;9344.01887801771;13076;14675.339609717801;14738.968272220842;14822.62943426423;15085.773713394088;10684.89315106839;12032.398380081137;12176.45205965716;12440.937795310965;12469.002479801775;11611.071114311004;11726.70683232926;11755.882441175821;12025.338606376734;12090.697732556404;12226.266424014588;12313.56902508408;12552.309622970824;12607.747845043232;12693.746125077632;7505.587192704454;9060.456372617664;9145.542722863696;9277.469217579293;9299.140171965499;12013.219140755822;12163.217784589;12199.878001219875;12254.75490490203;12371.75256494883 19:46:39 INFO - PID 1639 | |3;mootools.html;1390.6801435669795;1448.746469367861;1448.934797934092;1455.665197004689;1465.025757871016;10193.796124077524;11486.71283217919;11972.70068248292;12089.637310880677;12110.515579376837;11948.641540753792;12088.33514156721;12160.209586376879;12164.452599633016;12179.817302740445;2521.6343630173615;2576.0339872547793;2576.3687896465394;2578.265194419591;2578.445634188649;2506.3608779761134;2555.169569889784;2555.7955363570964;2556.9488610227786;2558.1302357198547;2489.26566662834;2495.6131799571094;2512.8617926014063;2519.2694118705554;2524.2301098165053;2478.1945867593104;2520.823542352036;2528.5448619248527;2534.1003943600035;2535.3154648245054;2430.1980346485616;2478;2489.414987477959;2511.547921374152;2555;12097.818532722016;12101.971332436753;12200.206986545845;12226.633201003984;12233.920233560317;6627.93372066278;6874.587524748531;6878.38094571486;6891.931080689179;6894.896576551356;4046.8785936421955;4372.584604462571;4439.600435960747;4442.178197033559;4445.488768791598;1245.3773113443278;1253.2793643654843;1280.206272111297;1297.7988411796186;1304.3282709404664;16442.588935276595;16924.407645732463;16966;16980.83019169805;17134.828651713447;4370.759608221515;5042.949570504321;5087;5577.2191893135;5801.042827933428;11943;12022.27866328023;12063.577774778016;12080.852319029678;12081;6509.349065093547;6565.113709649232;6592.274849766522;6594.142761440982;6597.47220222381;5360.65155764874;5389.9191512127345;6038.969805150946;6049.213602231682;6661.600303981777;3707.0547010512687;3717.312297225022;4241.363795430649;4389.473263208435;4412.22786012453;1301.3883474766844;1303.7001489657432;1311.141202512356;1311.2984553263957;1320.7028418605928;766.3447752171925;777.6461709921972;782.4249176855006;792.8771040488733;825.3768404854417;6547.247066587403;6801.557898736566;7073.893891591527;7108.111486064242;7211.71153153868;851.1573542193184;939.5020639061308;951.7906060666643;951.8048799995984;958.3483231402713;4135.379693046068;4378.824847006148;4432.667549933768;4442.53353397895;4464.486584042812;15113.3199006045;15495.535133946;15507.147106909228;15623.14072726011;15623.3750649975;14739.852601473847;15292.847071529142;15398.46105386306;15432.305546250445;15556.533304000672;7498.887516687363;8654.913450865537;8830.91169088301;8896.154865287788;8903.109689031045;5638.7462564185535;6280.277768056732;6936.653167341512;7147.821304467222;7237.276272372931;10797.62208322705;11072.280301780358;12639;13183.274919879499;13454.394552245369;13316.533921312708;13481.797773033217;13566.118202316818;13627.250501222132;13956.09285396446;9350.625974960925;9511.906130795047;9576.904230957602;9622.085901839315;9634.181094607036;10861.78276434451;10884.727881803019;10924.235303528994;10950.288231264942;10986.890131098906;9119.908800911906;9272.629094836131;9299;9347.485888276211;9402.95298523503;9053.728388148365;9155.633774648939;9211.585478653342;9227.984921658746;9300.162985331353;8259.297959673495;8262.297704694927;8363.03825060126;8370.790730231793;8372.288355489607;5967.283925928917;6075.908861366995;6179.69101544912;6210.378962103753;6262.279837818709;6139.907901381573;6194.659293738888;6304.117423560797;6318.08387783778;6353.0152826312 19:46:39 INFO - PID 1639 | |4;prototype.html;357.91410061585225;406.54263953052805;408.9631933126018;409.2919249698022;417.04704749647084;5667.696429821143;6031;6437.259715132761;6438.871222575545;6450.967745161273;5672.290963629546;6076.392360763922;6080.452759251666;6235.220597425322;6266.216722909637;4722.598579120779;4741.857744267669;4748.7863046163;4768.427788665365;4768.618510519167;3978.6220309070736;4322.84870029549;4761.90476190476;4803.18345881201;4817.445993710716;4227.577242275764;4446.622037126848;4454.309582014776;4472;4475.462944446655;4447.977760111211;4457.331400289966;4464.285714285715;4487.6634252431195;4503.48209955856;3754.4180651998986;3832.9616703833162;3834.827432765532;3835.86574469895;3846.4999550058315;5468.562514998791;5520.806771762969;6116.724747386378;6122.571420000601;6237.34507876671;5363.704996225206;5374.435684253175;5376.435474275223;5391.81128660495;5415.404305526389;5803.970980145073;6399.200099987502;6591.340865913418;6670.566413183127;6785.830354241134;4794.9280760788615;4837.588804951583;4853.587445067174;4853.611711063107;4884.3161957326;6095.6952152392205;6431.614103153779;6666.833329166761;6809.829754256134;7137.964310178468;4162.812673429703;4792.640551958547;4952.504749525018;4960.776765045582;4960.975195124073;4626.558503836355;4680.695754775928;5044.369453818273;5051;5130.79476820923;5509.201165830932;5616.550675945915;5658.943410565842;5671.404502527258;5719.942800572025;6716.764913228014;6718.7312507499155;6764.4926630502905;6790.32096790317;6807.4894382921475;1635.7568248131506;1654.7269700499523;1713.7258038713994;1725.1374312843577;1751.1419404491962;1165.906727461801;1204.0193881065773;1206.6922934651607;1216.671498695365;1221.3770976801718;5827.59206855516;6233.657148856856;6424.357564243538;6451.838704032437;6455.289918109004;6467.611943283418;6757.763478278237;6863.725450981905;6963.268856770068;7053.224145344008;5991.4907232884825;6097.298810636745;6381.150325752369;6381.500347418353;6433.359493329264;3010.3377257003426;3462.8614855406004;3551.2897420516;3628.673419392215;3628.800415977094;6268.247810262797;7085.043519124955;7154.964225178841;7162.92837071633;7179.712811487587;5893.381194974551;6283.465905398001;6880.380765731108;6998.790036298919;7156.570605763671;7160.176579693298;7184.46116541251;7211.639418029183;7212.423006159494;7228.168760592494;6317.115603815378;6590.912499437539;6631.204255489372;6914.0666010088;7022.367986881;6865.656717164022;6870.175578930561;6890.483213758888;6892;6893.586384816726;6967.79096627102;7059.117610298713;7078.43372530186;7182.773340264534;7199.424046076406;4374.759388233678;4381.715188512737;4388.61758546057;4398.934015989698;4419.867403977886;6835.58986460814;6972.942981820476;7014.123234595676;7037.225905150327;7087.893681594677;5565.858998905133;6418.261899881573;6582.308857569887;6659.304086232188;6666.400023997863;6015.5488338373925;6108.816735497942;6526.184226971629;6644.900326495203;6672.366125218096;5687.744051517774;5777.8555536111935;6151.9234134027265;6375.234971803413;6508.479321654351;5081.415637201769;6615.702293396905;6692.564983276072;6697.497687673346;6753.15585551806;5609.997302885873;6456.386643268882;6466.900626893345;6525.575837570543;6569.343065693392 19:46:39 INFO - PID 1639 | |5;yui.html;776.712616331957;778.8987431633889;839.9664013439462;846.2891171416013;885.6103314541604;16667.24997375118;17093.999999999985;17146.82853171468;18479.722804157915;19172.904135479337;17930.55173620657;18371.72442413365;18377.897326160408;18547.35084272051;18574.442766716988;988.7577543501852;988.7676396046924;1007.028217769852;1010.4038617215841;1011.6155860772933;1009.7374682582545;1012.997132838492;1013.8681971343752;1018.1091544898214;1018.2821111116682;1066.6906597086875;1073.3023534702427;1074.5970261152067;1077.6659235636978;1080.1089101491302;883.2007033634507;1068.9305195162328;1075.5428942699361;1075.5912753153752;1076.3111608570482;758.2720588235301;768.3123604374053;768.4774353439659;769.8383339498712;787.016229712859;15869.52391428259;17128.657426851518;17209.311627534884;17340.47978560645;17410.825891741046;17122;17374.652506949915;17523.912380438145;17534.561635959075;17565.121743912754;13612.455501780016;13950.790738138936;14089.225092619901;14229.501967431193;14252.287385630782;3483.372992861284;3542.3800834853796;3543.6633519815578;3547.929041419183;3555.768875023141;113764.99999999917;133752;133912;135990;136877;12620.17968832023;12812.55156069533;13514.526991555249;13564.457421703219;13677.179369237878;21720.674189887166;25162.119325823875;25492.8725356372;25762.742372576035;25829.3542661435;6087.29996050451;6842.007908853188;7198.5320954137815;7521;7588.772336829904;3002.429538387743;3718.330700473941;3739.775613463201;3742.9625703742613;3743.1390780120723;3740.756850804689;4274.871753847327;4407.228734971367;4435.645148388121;4440.4005459263235;940.9294302927308;951.900050494702;953.2564599612314;968.2931460034215;970.1850445625709;611.9871612481351;645.319188256394;651.8044586623994;653.1541653558653;691.7544271783545;10872;11461.770764584662;11778.234414763014;12061.638150855313;12122.27266364021;616.6392660293689;635.8664680417164;640.5676168586185;662.4667142949875;679.67035987546;4713.222318317507;5111.7699703513435;5356.250124982505;5529.087700529448;5668.0647693130995;83147;85118;109955;113060;119507;92250.53874730718;92559;93535.90168186338;93730.53134734283;94878;81481.59259203548;88113.91601294052;89172;89227.21545569182;90775.54612226896;12065.034797216376;12631;13051.804222936853;13064.412101455267;13156.407961641558;34676.65323346835;39861.80069099636;41385.79307103445;41972.48165110103;42104.78947605242;74306;74406;75665;76722.08194795175;78053;16601.750973735645;16812.663746724753;16923.492295231164;17007.659846802748;17031.914840425718;16982.320707171573;16990.895591786495;17838.464846054638;18489.90755046216;18914.810851891303;13976;14602.707945841235;16718.331266749195;16779.664406712043;17204.225809838335;16648.334066637683;16820.90664106829;16936.068516231724;17063.40278090261;17105.572360691083;13639.659008524866;16070.839291606935;16136.503707827025;16195;16460;9946.502674866084;11664.88335116638;11977.580784672495;12204.206726562745;12222.449989750305;12497;12704.237745735285;12992.480300787862;13317.933410332886;13347.66630834237 19:46:39 INFO - PID 1639 | __end_tp_report 19:46:39 INFO - PID 1639 | __start_cc_report 19:46:39 INFO - PID 1639 | _x_x_mozilla_cycle_collect,419 19:46:39 INFO - PID 1639 | __end_cc_report 19:46:39 INFO - PID 1639 | __startTimestamp1493261199328__endTimestamp 19:46:39 INFO - PID 1639 | 19:46:39 INFO - PID 1639 | ------- Summary: start ------- 19:46:39 INFO - PID 1639 | Number of tests: 6 19:46:39 INFO - PID 1639 | 19:46:39 INFO - PID 1639 | [#0] dojo.html Cycles:165 Average:6195.75 Median:6448.42 stddev:734.43 (11.4%) stddev-sans-first:707.14 19:46:39 INFO - PID 1639 | Values: 3567.2 3618.4 3626.9 3634.9 3640.7 5212.6 6091.2 6100.5 6122.2 6226.5 6167.7 6181.8 6218.4 6248.8 6296.2 5392.2 5421.9 5445.5 5459.8 5465.9 4949.5 5557.9 5580.0 5585.8 5619.3 5390.3 5391.1 5400.0 5493.4 5513.1 5481.5 5496.7 5542.1 5575.0 5598.9 5423.8 5470.9 5472.9 5475.7 5494.7 6094.7 6295.5 6309.5 6318.5 6321.9 6416.4 6522.0 6604.5 6703.7 6705.4 6826.1 6826.3 6829.6 6833.9 6867.3 6266.6 6287.5 6332.2 6332.3 6336.7 6685.0 6807.3 6936.7 6991.8 6994.3 6336.8 6402.9 6557.2 6571.8 6689.6 6802.5 6814.6 6858.1 6877.3 6886.5 6755.9 6765.9 6769.3 6777.9 6790.2 5412.6 6448.4 6677.2 6743.0 6786.8 5336.8 5372.9 5374.2 5375.4 5377.6 4629.6 4783.3 4787.2 4799.3 4806.9 6112.4 6194.2 6451.2 6455.8 6464.2 6623.5 6755.3 6770.5 6868.9 6878.0 6392.7 6398.5 6407.7 6409.0 6414.6 5099.0 5946.2 5963.7 5966.4 6008.1 6677.9 6767.1 6861.9 6942.5 7006.2 6739.8 6748.4 6763.8 6799.3 6812.6 6864.2 6942.9 6944.5 6946.3 6946.8 6426.5 6505.0 6658.2 6671.1 6672.7 6606.9 6816.3 6830.1 6856.0 6857.8 6306.8 6367.8 6645.3 6664.3 6673.5 6455.5 6551.6 6559.8 6563.2 6589.1 6216.4 6458.6 6519.7 6527.5 6534.0 6412.8 6426.8 6554.5 6566.6 6591.6 6472.5 6475.9 6478.3 6486.5 6489.4 19:46:39 INFO - PID 1639 | 19:46:39 INFO - PID 1639 | [#1] ext.html Cycles:180 Average:43796.84 Median:333607.00 stddev:76266.65 (22.9%) stddev-sans-first:76412.08 19:46:39 INFO - PID 1639 | Values: 739.7 805.1 826.9 1002.0 1201.4 36483.8 37180.4 37198.5 37263.3 37266.1 36897.0 36939.0 37174.9 37273.6 37287.0 7790.5 8182.6 8425.7 8476.6 8490.0 8387.6 8515.1 8523.6 8529.4 8556.3 8456.2 8525.8 8526.6 8540.2 8577.9 7212.2 8398.6 8492.5 8527.5 8532.1 8304.0 8318.9 8352.8 8358.8 8367.9 36119.8 36217.6 36254.1 36295.5 36380.0 3628.8 3669.4 3683.1 3683.8 3684.7 30348.2 30413.1 30484.9 30503.7 30576.1 3052.9 3102.6 3106.7 3118.8 3125.8 242899.0 245616.5 264299.0 303493.0 303669.0 37591.6 38874.4 39210.6 45465.8 45468.0 45070.6 47664.4 47878.4 47885.8 47923.0 14081.6 14119.4 14222.2 14225.1 14237.5 9930.4 11567.5 11641.2 11645.5 11653.5 12053.4 12588.5 13135.9 13204.4 13388.5 5903.5 5952.3 5979.5 6014.6 6015.5 1022.0 1026.7 1042.4 1066.3 1078.7 22877.3 23884.0 24085.3 24164.8 24413.9 1001.8 1135.8 1146.8 1177.0 1182.8 10324.0 11855.1 12222.1 12241.6 12276.2 330801.0 331952.0 333467.0 333747.0 334173.0 52025.7 52036.2 52224.0 52294.0 52358.2 1494.0 1525.5 1559.9 1561.4 1585.2 19197.0 19983.5 23516.0 23673.9 24075.6 36738.8 47403.5 48480.5 48506.0 48709.0 260484.0 260700.0 261302.0 261609.0 262042.0 32142.8 32177.7 33516.3 33688.8 33733.8 41987.0 42777.0 44412.6 44556.9 44695.0 26842.6 29618.7 30356.1 30587.8 30923.2 30589.2 30682.8 30687.8 30722.7 30776.9 36886.4 37029.0 37041.6 37172.8 37249.4 26804.5 29213.3 30472.0 30804.0 30843.4 22312.3 23873.0 23985.0 24328.3 24564.1 19:46:39 INFO - PID 1639 | 19:46:39 INFO - PID 1639 | [#2] jquery.html Cycles:180 Average:36995.76 Median:2295.47 stddev:96258.30 (4193.4%) stddev-sans-first:96489.08 19:46:39 INFO - PID 1639 | Values: 382.4 423.5 423.8 436.3 436.6 21141.7 21403.4 22058.9 22547.0 22691.2 22158.0 22677.9 22701.0 22886.2 23004.1 5364.8 5968.6 6204.1 6208.3 6212.0 5854.5 6100.7 6167.5 6172.1 6180.2 5917.0 6076.4 6122.7 6124.7 6130.9 5953.2 6084.1 6103.6 6120.8 6128.1 5281.5 5355.9 5376.6 5430.5 5455.5 26422.3 26538.9 26635.0 26740.9 26809.6 2223.9 2295.4 2295.5 2296.2 2300.0 15725.7 17454.2 17925.6 17955.0 18024.0 2188.7 2196.8 2218.7 2219.5 2224.7 167721.0 168305.0 168609.0 171403.1 171659.0 10697.8 12755.0 12800.4 13079.6 13168.7 16586.3 16752.6 16790.0 16792.8 16797.2 8685.6 8981.1 9025.9 9079.5 9113.0 8431.4 8443.2 8454.6 8591.6 8636.4 7933.4 7970.0 8012.7 8017.9 8059.8 2207.0 2210.8 2212.1 2213.8 2376.5 973.9 982.0 998.2 1002.0 1033.2 20394.0 21066.3 21325.3 25631.5 27374.7 1019.4 1020.3 1027.0 1049.3 1053.0 10747.2 11153.0 11215.7 11255.8 11296.9 556788.0 560545.0 561671.0 570687.0 572706.0 132101.0 134271.0 134440.0 137081.0 139695.0 1207.9 1236.2 1264.7 1271.9 1275.5 21982.2 23145.7 23161.3 23291.7 23322.0 58213.1 58796.0 59160.0 59169.0 59747.7 78740.0 81261.0 81887.2 83347.0 83727.0 8633.0 8762.1 8915.4 8944.9 9344.0 13076.0 14675.3 14739.0 14822.6 15085.8 10684.9 12032.4 12176.5 12440.9 12469.0 11611.1 11726.7 11755.9 12025.3 12090.7 12226.3 12313.6 12552.3 12607.7 12693.7 7505.6 9060.5 9145.5 9277.5 9299.1 12013.2 12163.2 12199.9 12254.8 12371.8 19:46:39 INFO - PID 1639 | 19:46:39 INFO - PID 1639 | [#3] mootools.html Cycles:180 Average:7190.23 Median:3712.18 stddev:4565.61 (123.0%) stddev-sans-first:4557.62 19:46:39 INFO - PID 1639 | Values: 1390.7 1448.7 1448.9 1455.7 1465.0 10193.8 11486.7 11972.7 12089.6 12110.5 11948.6 12088.3 12160.2 12164.5 12179.8 2521.6 2576.0 2576.4 2578.3 2578.4 2506.4 2555.2 2555.8 2556.9 2558.1 2489.3 2495.6 2512.9 2519.3 2524.2 2478.2 2520.8 2528.5 2534.1 2535.3 2430.2 2478.0 2489.4 2511.5 2555.0 12097.8 12102.0 12200.2 12226.6 12233.9 6627.9 6874.6 6878.4 6891.9 6894.9 4046.9 4372.6 4439.6 4442.2 4445.5 1245.4 1253.3 1280.2 1297.8 1304.3 16442.6 16924.4 16966.0 16980.8 17134.8 4370.8 5042.9 5087.0 5577.2 5801.0 11943.0 12022.3 12063.6 12080.9 12081.0 6509.3 6565.1 6592.3 6594.1 6597.5 5360.7 5389.9 6039.0 6049.2 6661.6 3707.1 3717.3 4241.4 4389.5 4412.2 1301.4 1303.7 1311.1 1311.3 1320.7 766.3 777.6 782.4 792.9 825.4 6547.2 6801.6 7073.9 7108.1 7211.7 851.2 939.5 951.8 951.8 958.3 4135.4 4378.8 4432.7 4442.5 4464.5 15113.3 15495.5 15507.1 15623.1 15623.4 14739.9 15292.8 15398.5 15432.3 15556.5 7498.9 8654.9 8830.9 8896.2 8903.1 5638.7 6280.3 6936.7 7147.8 7237.3 10797.6 11072.3 12639.0 13183.3 13454.4 13316.5 13481.8 13566.1 13627.3 13956.1 9350.6 9511.9 9576.9 9622.1 9634.2 10861.8 10884.7 10924.2 10950.3 10986.9 9119.9 9272.6 9299.0 9347.5 9403.0 9053.7 9155.6 9211.6 9228.0 9300.2 8259.3 8262.3 8363.0 8370.8 8372.3 5967.3 6075.9 6179.7 6210.4 6262.3 6139.9 6194.7 6304.1 6318.1 6353.0 19:46:39 INFO - PID 1639 | 19:46:39 INFO - PID 1639 | [#4] prototype.html Cycles:180 Average:5446.72 Median:6078.42 stddev:1670.54 (27.5%) stddev-sans-first:1630.98 19:46:39 INFO - PID 1639 | Values: 357.9 406.5 409.0 409.3 417.0 5667.7 6031.0 6437.3 6438.9 6451.0 5672.3 6076.4 6080.5 6235.2 6266.2 4722.6 4741.9 4748.8 4768.4 4768.6 3978.6 4322.8 4761.9 4803.2 4817.4 4227.6 4446.6 4454.3 4472.0 4475.5 4448.0 4457.3 4464.3 4487.7 4503.5 3754.4 3833.0 3834.8 3835.9 3846.5 5468.6 5520.8 6116.7 6122.6 6237.3 5363.7 5374.4 5376.4 5391.8 5415.4 5804.0 6399.2 6591.3 6670.6 6785.8 4794.9 4837.6 4853.6 4853.6 4884.3 6095.7 6431.6 6666.8 6809.8 7138.0 4162.8 4792.6 4952.5 4960.8 4961.0 4626.6 4680.7 5044.4 5051.0 5130.8 5509.2 5616.6 5658.9 5671.4 5719.9 6716.8 6718.7 6764.5 6790.3 6807.5 1635.8 1654.7 1713.7 1725.1 1751.1 1165.9 1204.0 1206.7 1216.7 1221.4 5827.6 6233.7 6424.4 6451.8 6455.3 6467.6 6757.8 6863.7 6963.3 7053.2 5991.5 6097.3 6381.2 6381.5 6433.4 3010.3 3462.9 3551.3 3628.7 3628.8 6268.2 7085.0 7155.0 7162.9 7179.7 5893.4 6283.5 6880.4 6998.8 7156.6 7160.2 7184.5 7211.6 7212.4 7228.2 6317.1 6590.9 6631.2 6914.1 7022.4 6865.7 6870.2 6890.5 6892.0 6893.6 6967.8 7059.1 7078.4 7182.8 7199.4 4374.8 4381.7 4388.6 4398.9 4419.9 6835.6 6972.9 7014.1 7037.2 7087.9 5565.9 6418.3 6582.3 6659.3 6666.4 6015.5 6108.8 6526.2 6644.9 6672.4 5687.7 5777.9 6151.9 6375.2 6508.5 5081.4 6615.7 6692.6 6697.5 6753.2 5610.0 6456.4 6466.9 6525.6 6569.3 19:46:39 INFO - PID 1639 | 19:46:39 INFO - PID 1639 | [#5] yui.html Cycles:180 Average:22678.91 Median:18151.14 stddev:32363.33 (178.3%) stddev-sans-first:32412.34 19:46:39 INFO - PID 1639 | Values: 776.7 778.9 840.0 846.3 885.6 16667.2 17094.0 17146.8 18479.7 19172.9 17930.6 18371.7 18377.9 18547.4 18574.4 988.8 988.8 1007.0 1010.4 1011.6 1009.7 1013.0 1013.9 1018.1 1018.3 1066.7 1073.3 1074.6 1077.7 1080.1 883.2 1068.9 1075.5 1075.6 1076.3 758.3 768.3 768.5 769.8 787.0 15869.5 17128.7 17209.3 17340.5 17410.8 17122.0 17374.7 17523.9 17534.6 17565.1 13612.5 13950.8 14089.2 14229.5 14252.3 3483.4 3542.4 3543.7 3547.9 3555.8 113765.0 133752.0 133912.0 135990.0 136877.0 12620.2 12812.6 13514.5 13564.5 13677.2 21720.7 25162.1 25492.9 25762.7 25829.4 6087.3 6842.0 7198.5 7521.0 7588.8 3002.4 3718.3 3739.8 3743.0 3743.1 3740.8 4274.9 4407.2 4435.6 4440.4 940.9 951.9 953.3 968.3 970.2 612.0 645.3 651.8 653.2 691.8 10872.0 11461.8 11778.2 12061.6 12122.3 616.6 635.9 640.6 662.5 679.7 4713.2 5111.8 5356.3 5529.1 5668.1 83147.0 85118.0 109955.0 113060.0 119507.0 92250.5 92559.0 93535.9 93730.5 94878.0 81481.6 88113.9 89172.0 89227.2 90775.5 12065.0 12631.0 13051.8 13064.4 13156.4 34676.7 39861.8 41385.8 41972.5 42104.8 74306.0 74406.0 75665.0 76722.1 78053.0 16601.8 16812.7 16923.5 17007.7 17031.9 16982.3 16990.9 17838.5 18489.9 18914.8 13976.0 14602.7 16718.3 16779.7 17204.2 16648.3 16820.9 16936.1 17063.4 17105.6 13639.7 16070.8 16136.5 16195.0 16460.0 9946.5 11664.9 11977.6 12204.2 12222.4 12497.0 12704.2 12992.5 13317.9 13347.7 19:46:39 INFO - PID 1639 | -------- Summary: end -------- 19:46:39 INFO - PID 1639 | 19:46:39 INFO - TEST-INFO | 1639: exit 0 19:46:39 INFO - TEST-OK | dromaeo_css | took 1115956ms 19:46:39 INFO - TEST-START | kraken 19:46:39 INFO - operating with platform_type : mac_ 19:46:39 INFO - Initialising browser for kraken test... 19:46:39 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/tmpjx07Y0/profile http://localhost:49240/getInfo.html) 19:46:42 INFO - PID 1649 | 2017-04-26 19:46:42.756 plugin-container[1650:10367] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4443, name = 'com.apple.tsm.portname' 19:46:42 INFO - PID 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:46:42 INFO - PID 1649 | 2017-04-26 19:46:42.759 plugin-container[1650:10367] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9a0b, name = 'com.apple.CFPasteboardClient' 19:46:42 INFO - PID 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:46:42 INFO - PID 1649 | 2017-04-26 19:46:42.759 plugin-container[1650:10367] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 19:46:42 INFO - PID 1649 | __metrics Screen width/height:1600/1200 19:46:42 INFO - PID 1649 | colorDepth:24 19:46:42 INFO - PID 1649 | Browser inner width/height: 1024/689 19:46:42 INFO - PID 1649 | __metrics 19:46:42 ERROR - PID 1649 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3424: TypeError: this.tabs is undefined 19:46:43 INFO - TEST-INFO | 1649: exit 0 19:46:43 INFO - Browser initialized. 19:46:43 INFO - Running cycle 1/1 for kraken test... 19:46:43 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/tmpjx07Y0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:46:46 INFO - PID 1651 | 2017-04-26 19:46:46.579 plugin-container[1652:10482] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x463f, name = 'com.apple.tsm.portname' 19:46:46 INFO - PID 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:46:46 INFO - PID 1651 | 2017-04-26 19:46:46.580 plugin-container[1652:10482] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9723, name = 'com.apple.CFPasteboardClient' 19:46:46 INFO - PID 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:46:46 INFO - PID 1651 | 2017-04-26 19:46:46.580 plugin-container[1652:10482] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 19:46:56 INFO - PID 1651 | RSS: Main: 236404736 19:46:56 INFO - PID 1651 | 19:46:58 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection) 19:46:59 INFO - PID 1651 | RSS: Main: 248856576 19:46:59 INFO - PID 1651 | 19:47:02 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-dft) 19:47:03 INFO - PID 1651 | RSS: Main: 256888832 19:47:03 INFO - PID 1651 | 19:47:06 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-fft) 19:47:07 INFO - PID 1651 | RSS: Main: 259088384 19:47:07 INFO - PID 1651 | 19:47:09 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator) 19:47:09 INFO - PID 1651 | RSS: Main: 260636672 19:47:09 INFO - PID 1651 | 19:47:11 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:47:12 INFO - PID 1651 | RSS: Main: 260968448 19:47:12 INFO - PID 1651 | 19:47:15 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom) 19:47:15 INFO - PID 1651 | RSS: Main: 266473472 19:47:15 INFO - PID 1651 | 19:47:18 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate) 19:47:19 INFO - PID 1651 | RSS: Main: 268259328 19:47:19 INFO - PID 1651 | 19:47:22 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial) 19:47:23 INFO - PID 1651 | RSS: Main: 267546624 19:47:23 INFO - PID 1651 | 19:47:24 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:47:25 INFO - PID 1651 | RSS: Main: 266940416 19:47:25 INFO - PID 1651 | 19:47:27 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:47:27 INFO - PID 1651 | RSS: Main: 266993664 19:47:27 INFO - PID 1651 | 19:47:29 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:47:30 INFO - PID 1651 | RSS: Main: 266665984 19:47:30 INFO - PID 1651 | 19:47:33 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:47:34 INFO - PID 1651 | RSS: Main: 266702848 19:47:34 INFO - PID 1651 | 19:47:37 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:47:38 INFO - PID 1651 | RSS: Main: 265572352 19:47:38 INFO - PID 1651 | 19:47:39 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49240/tests/kraken/driver.html?testName=ai-astar) 19:47:40 INFO - PID 1651 | RSS: Main: 267431936 19:47:40 INFO - PID 1651 | 19:47:40 INFO - PID 1651 | __start_tp_report 19:47:40 INFO - PID 1651 | _x_x_mozilla_page_load 19:47:40 INFO - PID 1651 | _x_x_mozilla_page_load_details 19:47:40 INFO - PID 1651 | |i|pagename|runs| 19:47:40 INFO - PID 1651 | |0;ai-astar;104;117;112;113;116;112;114;114;114;129 19:47:40 INFO - PID 1651 | |1;audio-beat-detection;133;122;143;181;136;112;110;113;138;110 19:47:40 INFO - PID 1651 | |2;audio-dft;225;197;203;246;242;250;253;286;212;201 19:47:40 INFO - PID 1651 | |3;audio-fft;82;59;57;81;57;58;59;52;78;66 19:47:40 INFO - PID 1651 | |4;audio-oscillator;89;71;81;72;73;70;104;103;84;92 19:47:40 INFO - PID 1651 | |5;imaging-gaussian-blur;89;92;90;89;90;89;103;88;89;89 19:47:40 INFO - PID 1651 | |6;imaging-darkroom;97;125;103;153;97;97;97;98;97;105 19:47:40 INFO - PID 1651 | |7;imaging-desaturate;91;96;91;136;148;92;93;87;93;92 19:47:40 INFO - PID 1651 | |8;json-parse-financial;50;50;49;50;52;51;51;50;65;51 19:47:40 INFO - PID 1651 | |9;json-stringify-tinderbox;55;60;67;64;64;63;59;54;55;70 19:47:40 INFO - PID 1651 | |10;stanford-crypto-aes;84;81;83;84;84;82;82;83;86;82 19:47:40 INFO - PID 1651 | |11;stanford-crypto-ccm;134;137;141;127;154;149;149;158;187;139 19:47:40 INFO - PID 1651 | |12;stanford-crypto-pbkdf2;188;216;199;223;235;204;221;194;190;189 19:47:40 INFO - PID 1651 | |13;stanford-crypto-sha256-iterative;68;69;67;87;94;80;66;68;66;70 19:47:40 INFO - PID 1651 | __end_tp_report 19:47:40 INFO - PID 1651 | __start_cc_report 19:47:40 INFO - PID 1651 | _x_x_mozilla_cycle_collect,1007 19:47:40 INFO - PID 1651 | __end_cc_report 19:47:40 INFO - PID 1651 | __startTimestamp1493261260056__endTimestamp 19:47:40 INFO - PID 1651 | 19:47:40 INFO - PID 1651 | ------- Summary: start ------- 19:47:40 INFO - PID 1651 | Number of tests: 14 19:47:40 INFO - PID 1651 | 19:47:40 INFO - PID 1651 | [#0] ai-astar Cycles:10 Average:114.50 Median:114.00 stddev:6.19 (5.4%) stddev-sans-first:5.27 19:47:40 INFO - PID 1651 | Values: 104.0 117.0 112.0 113.0 116.0 112.0 114.0 114.0 114.0 129.0 19:47:40 INFO - PID 1651 | 19:47:40 INFO - PID 1651 | [#1] audio-beat-detection Cycles:10 Average:129.80 Median:134.50 stddev:22.00 (16.4%) stddev-sans-first:23.30 19:47:40 INFO - PID 1651 | Values: 133.0 122.0 143.0 181.0 136.0 112.0 110.0 113.0 138.0 110.0 19:47:40 INFO - PID 1651 | 19:47:40 INFO - PID 1651 | [#2] audio-dft Cycles:10 Average:231.50 Median:244.00 stddev:28.77 (11.8%) stddev-sans-first:30.42 19:47:40 INFO - PID 1651 | Values: 225.0 197.0 203.0 246.0 242.0 250.0 253.0 286.0 212.0 201.0 19:47:40 INFO - PID 1651 | 19:47:40 INFO - PID 1651 | [#3] audio-fft Cycles:10 Average:64.90 Median:62.50 stddev:11.22 (18.0%) stddev-sans-first:10.05 19:47:40 INFO - PID 1651 | Values: 82.0 59.0 57.0 81.0 57.0 58.0 59.0 52.0 78.0 66.0 19:47:40 INFO - PID 1651 | 19:47:40 INFO - PID 1651 | [#4] audio-oscillator Cycles:10 Average:83.90 Median:77.00 stddev:12.86 (16.7%) stddev-sans-first:13.51 19:47:40 INFO - PID 1651 | Values: 89.0 71.0 81.0 72.0 73.0 70.0 104.0 103.0 84.0 92.0 19:47:40 INFO - PID 1651 | 19:47:40 INFO - PID 1651 | [#5] imaging-gaussian-blur Cycles:10 Average:90.80 Median:89.00 stddev:4.42 (5.0%) stddev-sans-first:4.64 19:47:40 INFO - PID 1651 | Values: 89.0 92.0 90.0 89.0 90.0 89.0 103.0 88.0 89.0 89.0 19:47:40 INFO - PID 1651 | 19:47:40 INFO - PID 1651 | [#6] imaging-darkroom Cycles:10 Average:106.90 Median:97.00 stddev:18.38 (18.9%) stddev-sans-first:19.14 19:47:40 INFO - PID 1651 | Values: 97.0 125.0 103.0 153.0 97.0 97.0 97.0 98.0 97.0 105.0 19:47:40 INFO - PID 1651 | 19:47:40 INFO - PID 1651 | [#7] imaging-desaturate Cycles:10 Average:101.90 Median:92.00 stddev:21.44 (23.3%) stddev-sans-first:22.37 19:47:40 INFO - PID 1651 | Values: 91.0 96.0 91.0 136.0 148.0 92.0 93.0 87.0 93.0 92.0 19:47:40 INFO - PID 1651 | 19:47:40 INFO - PID 1651 | [#8] json-parse-financial Cycles:10 Average:51.90 Median:51.00 stddev:4.68 (9.2%) stddev-sans-first:4.91 19:47:40 INFO - PID 1651 | Values: 50.0 50.0 49.0 50.0 52.0 51.0 51.0 50.0 65.0 51.0 19:47:40 INFO - PID 1651 | 19:47:40 INFO - PID 1651 | [#9] json-stringify-tinderbox Cycles:10 Average:61.10 Median:63.50 stddev:5.43 (8.5%) stddev-sans-first:5.29 19:47:40 INFO - PID 1651 | Values: 55.0 60.0 67.0 64.0 64.0 63.0 59.0 54.0 55.0 70.0 19:47:40 INFO - PID 1651 | 19:47:40 INFO - PID 1651 | [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:83.50 stddev:1.45 (1.7%) stddev-sans-first:1.50 19:47:40 INFO - PID 1651 | Values: 84.0 81.0 83.0 84.0 84.0 82.0 82.0 83.0 86.0 82.0 19:47:40 INFO - PID 1651 | 19:47:40 INFO - PID 1651 | [#11] stanford-crypto-ccm Cycles:10 Average:147.50 Median:149.00 stddev:16.81 (11.3%) stddev-sans-first:17.11 19:47:40 INFO - PID 1651 | Values: 134.0 137.0 141.0 127.0 154.0 149.0 149.0 158.0 187.0 139.0 19:47:40 INFO - PID 1651 | 19:47:40 INFO - PID 1651 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:205.90 Median:210.00 stddev:16.74 (8.0%) stddev-sans-first:16.45 19:47:40 INFO - PID 1651 | Values: 188.0 216.0 199.0 223.0 235.0 204.0 221.0 194.0 190.0 189.0 19:47:40 INFO - PID 1651 | 19:47:40 INFO - PID 1651 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.50 Median:69.50 stddev:9.96 (14.3%) stddev-sans-first:10.36 19:47:40 INFO - PID 1651 | Values: 68.0 69.0 67.0 87.0 94.0 80.0 66.0 68.0 66.0 70.0 19:47:40 INFO - PID 1651 | -------- Summary: end -------- 19:47:40 INFO - PID 1651 | 19:47:41 INFO - TEST-INFO | 1651: exit 0 19:47:41 INFO - TEST-OK | kraken | took 61387ms 19:47:41 INFO - SUITE-END | took 1177s 19:47:41 INFO - Completed test suite (00:19:37) 19:47:41 INFO - javascript benchmark 19:47:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7981.02316357643, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3567.161716996505, 3618.40296351102, 3626.854925802968, 3634.927301453971, 3640.7087433005354, 5212.609054320927, 6091.177691011712, 6100.511959043277, 6122.204113465249, 6226.501879849612, 6167.691615419233, 6181.845453863656, 6218.4092511211475, 6248.812535623939, 6296.181496405461, 5392.1911713243135, 5421.9457805421835, 5445.455454454563, 5459.836204913859, 5465.879494703586, 4949.480304568023, 5557.916631250535, 5580.0, 5585.804496842611, 5619.297587801525, 5390.272313237702, 5391.083515802323, 5400.0, 5493.368262649807, 5513.117901135799, 5481.451854814526, 5496.6701997880255, 5542.11326187812, 5574.9721251393885, 5598.944010559883, 5423.755930983115, 5470.91793623096, 5472.91790623141, 5475.7262136893, 5494.697791621459, 6094.725737341831, 6295.527835412317, 6309.495240380758, 6318.526110541682, 6321.87356252877, 6416.422521973045, 6522.0, 6604.537682362236, 6703.698333575001, 6705.396514313687, 6826.078479405266, 6826.317368263183, 6829.6243706596115, 6833.931660683379, 6867.313268673142, 6266.592671476339, 6287.465565426898, 6332.176817013851, 6332.271788744308, 6336.746530138835, 6684.966575167093, 6807.319268073252, 6936.722531098801, 6991.7902462926195, 6994.300569943067, 6336.778212762623, 6402.9359706403275, 6557.180352455943, 6571.80284591463, 6689.565178263398, 6802.523823332418, 6814.557053791487, 6858.108445902001, 6877.346652068046, 6886.48351373649, 6755.932440675629, 6765.932340676629, 6769.32306769329, 6777.932220677829, 6790.219124800612, 5412.56699464042, 6448.419642232222, 6677.23211830636, 6743.0, 6786.76246331376, 5336.7865285388925, 5372.946270537244, 5374.247605335257, 5375.435579264199, 5377.569794416438, 4629.629629629621, 4783.258594917794, 4787.210110331756, 4799.3041009053495, 4806.855794326176, 6112.419320164578, 6194.194754681863, 6451.161349024596, 6455.7740479083, 6464.159659244268, 6623.4701223901975, 6755.256921738604, 6770.4922130839395, 6868.862622747517, 6877.965610171917, 6392.680365981682, 6398.488120950313, 6407.7436902524305, 6409.038644203313, 6414.583052101599, 5099.0, 5946.1972633693895, 5963.73163207648, 5966.403359664086, 6008.09878518217, 6677.933220667731, 6767.120274364301, 6861.897071544031, 6942.51402401827, 7006.229314775473, 6739.797806065826, 6748.358905903931, 6763.7632682855865, 6799.252082271045, 6812.591244525344, 6864.176298844171, 6942.895856562257, 6944.51388402807, 6946.340097690711, 6946.79159625212, 6426.485881129592, 6505.0, 6658.167729033871, 6671.066050752996, 6672.6997285121315, 6606.867862642816, 6816.318368163144, 6830.112085428863, 6856.0, 6857.828554285983, 6306.779262725782, 6367.777127800505, 6645.3022432643875, 6664.333566643297, 6673.532852700265, 6455.4512866406885, 6551.639659818756, 6559.8032059038305, 6563.212414510289, 6589.077529145828, 6216.378362163748, 6458.612483250832, 6519.7392104315295, 6527.5430719849155, 6533.967330163318, 6412.839679008062, 6426.839329016812, 6554.508411869034, 6566.606003639797, 6591.571547849375, 6472.546921715623, 6475.870482590228, 6478.3197764235965, 6486.481081513373, 6489.448396886129], "value": 6146.891534387353, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [739.7313607163717, 805.1103530598689, 826.8919647672118, 1001.959921603136, 1201.4173126033872, 36483.817580912095, 37180.442293365624, 37198.512059517656, 37263.254734905284, 37266.06834829131, 36897.0, 36939.0, 37174.88475345737, 37273.62726372736, 37287.0, 7790.532568045921, 8182.590870456484, 8425.747227583182, 8476.618552165168, 8490.0, 8387.580620968927, 8515.063343032261, 8523.57382130891, 8529.445586036887, 8556.315494760403, 8456.154384561556, 8525.786855328604, 8526.57367131644, 8540.188682075193, 8577.914220857805, 7212.2427145149795, 8398.622062007194, 8492.53291068991, 8527.488350698977, 8532.061473237938, 8304.0, 8318.875216871751, 8352.83294334116, 8358.83282334356, 8367.874481882776, 36119.81940090309, 36217.63782362169, 36254.09364765875, 36295.4555681665, 36380.0, 3628.838771593091, 3669.4495825626104, 3683.0976410779263, 3683.797391143486, 3684.7420680552373, 30348.241293967607, 30413.08760737159, 30484.93302734416, 30503.69496305053, 30576.08271751851, 3052.862621182052, 3102.5811515445575, 3106.7203951644233, 3118.7504999600205, 3125.828079455629, 242899.0, 245616.54383456116, 264299.0, 303493.0, 303669.0, 37591.62408375881, 38874.416883746766, 39210.62762803345, 45465.77267113643, 45468.0, 45070.647880563636, 47664.42516811253, 47878.366689831695, 47885.76057119692, 47923.0, 14081.647958800908, 14119.364628591738, 14222.2177780221, 14225.14649121056, 14237.50168744089, 9930.404175749478, 11567.537298508134, 11641.185117041896, 11645.475953582109, 11653.53385864573, 12053.397330133459, 12588.496460141492, 13135.934320328337, 13204.405801738752, 13388.464461421629, 5903.468687818117, 5952.345242023374, 5979.491743201789, 6014.6391216527145, 6015.4586087252355, 1021.9897801021895, 1026.7176526455285, 1042.4318746283143, 1066.3495267886583, 1078.724925144099, 22877.31368058961, 23884.0, 24085.33237499136, 24164.758352416604, 24413.877930610233, 1001.7545701303227, 1135.784201001807, 1146.7763786061805, 1177.0465922602718, 1182.798924182891, 10324.0, 11855.05159587231, 12222.083343749255, 12241.571544995883, 12276.202046866925, 330801.0, 331952.0, 333467.0, 333747.0, 334173.0, 52025.7398713004, 52036.21945670818, 52223.95552089013, 52294.0, 52358.16746413857, 1493.9701205975819, 1525.4889611979888, 1559.9220038998005, 1561.375449820081, 1585.1519437101097, 19197.0, 19983.469099165628, 23516.0, 23673.881630591735, 24075.638865417382, 36738.8163059183, 47403.525964739914, 48480.51519484901, 48506.02987940292, 48709.0, 260484.0, 260700.0, 261302.0, 261609.0, 262042.0, 32142.83928580342, 32177.678223217466, 33516.329673406886, 33688.83155584305, 33733.81931632381, 41987.0, 42777.0, 44412.55587444084, 44556.886077848314, 44695.0, 26842.597361039992, 29618.703812961594, 30356.089317320515, 30587.847060764554, 30923.226919327197, 30589.23526911756, 30682.84658576693, 30687.846560767055, 30722.692773071984, 30776.922807701623, 36886.44670330001, 37029.0, 37041.62958370382, 37172.81413593023, 37249.44125838169, 26804.463910722065, 29213.269668258465, 30472.0, 30804.0, 30843.383132337676, 22312.330630081124, 23873.045078197374, 23985.0, 24328.27015189547, 24564.140255090984], "value": 17269.637609605597, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.42445120094254, 423.5489203997742, 423.79022383919965, 436.31280732845767, 436.60923473491226, 21141.68287475689, 21403.35789926303, 22058.897055147238, 22547.0, 22691.20580779669, 22158.0, 22677.86610669464, 22701.0, 22886.230643684565, 23004.079836806548, 5364.785408583672, 5968.5523585731025, 6204.100405441209, 6208.317085120633, 6211.968940155293, 5854.5023672987845, 6100.694965251741, 6167.537434692394, 6172.135900973867, 6180.165677633529, 5916.970415147918, 6076.392360763933, 6122.6632535210765, 6124.6631435271265, 6130.938690613104, 5953.196318496991, 6084.056971169476, 6103.603265787754, 6120.755169793203, 6128.1114238435175, 5281.52466278033, 5355.866103347408, 5376.596755243333, 5430.456954304538, 5455.536279416255, 26422.339441514116, 26538.86730566335, 26635.0, 26740.8662956684, 26809.597856032175, 2223.855449395784, 2295.414669259328, 2295.5294164696197, 2296.196331284037, 2299.954000919989, 15725.685486290324, 17454.214560344815, 17925.64148717018, 17955.0, 18024.0, 2188.6607575825774, 2196.8352373572047, 2218.7004754358118, 2219.4784225706944, 2224.73303203615, 167721.0, 168305.0, 168608.99999999878, 171403.1429842855, 171659.0, 10697.786044279072, 12755.043371747157, 12800.423980920881, 13079.607611771662, 13168.73662526744, 16586.336546538245, 16752.58118547022, 16789.992600444013, 16792.83207167937, 16797.244124014447, 8685.632118815496, 8981.14679105484, 9025.864612030824, 9079.45523268606, 9112.95443522778, 8431.367647426467, 8443.197896199852, 8454.61954212062, 8591.5704214789, 8636.352273579507, 7933.404994625311, 7970.0, 8012.719554815553, 8017.879731804028, 8059.838803223903, 2206.9889650551645, 2210.7789221077765, 2212.104097840377, 2213.8339624528226, 2376.4534157143607, 973.868527748759, 981.955811988448, 998.1765043838717, 1001.9849702254472, 1033.235405799703, 20393.98030098489, 21066.2626808061, 21325.253616123362, 25631.48737025249, 27374.72625273722, 1019.4444028004755, 1020.321486211661, 1026.9640562580273, 1049.3074570783247, 1052.9736756580994, 10747.193960452998, 11153.0, 11215.71960700989, 11255.774884502263, 11296.887031129749, 556788.0, 560545.0, 561671.0, 570687.0, 572706.0, 132101.0, 134271.0, 134440.0, 137081.0, 139695.0, 1207.9214851034656, 1236.2150034727833, 1264.6775072356675, 1271.8855303022588, 1275.5471807508386, 21982.230621928156, 23145.726985015986, 23161.3051608452, 23291.71895545761, 23322.0, 58213.126803098836, 58796.0, 59160.0, 59169.0, 59747.701261493414, 78740.0, 81261.0, 81887.18112818795, 83347.0, 83727.0, 8632.956835216035, 8762.123787621442, 8915.37592368528, 8944.910550894409, 9344.01887801771, 13076.0, 14675.339609717801, 14738.968272220842, 14822.62943426423, 15085.773713394088, 10684.89315106839, 12032.398380081137, 12176.45205965716, 12440.937795310965, 12469.002479801775, 11611.071114311004, 11726.70683232926, 11755.882441175821, 12025.338606376734, 12090.697732556404, 12226.266424014588, 12313.56902508408, 12552.309622970824, 12607.747845043232, 12693.746125077632, 7505.587192704454, 9060.456372617664, 9145.542722863696, 9277.469217579293, 9299.140171965499, 12013.219140755822, 12163.217784589, 12199.878001219875, 12254.75490490203, 12371.75256494883], "value": 10717.650706595108, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1390.6801435669795, 1448.746469367861, 1448.934797934092, 1455.665197004689, 1465.025757871016, 10193.796124077524, 11486.71283217919, 11972.70068248292, 12089.637310880677, 12110.515579376837, 11948.641540753792, 12088.33514156721, 12160.209586376879, 12164.452599633016, 12179.817302740445, 2521.6343630173615, 2576.0339872547793, 2576.3687896465394, 2578.265194419591, 2578.445634188649, 2506.3608779761134, 2555.169569889784, 2555.7955363570964, 2556.9488610227786, 2558.1302357198547, 2489.26566662834, 2495.6131799571094, 2512.8617926014063, 2519.2694118705554, 2524.2301098165053, 2478.1945867593104, 2520.823542352036, 2528.5448619248527, 2534.1003943600035, 2535.3154648245054, 2430.1980346485616, 2478.0, 2489.414987477959, 2511.547921374152, 2555.0, 12097.818532722016, 12101.971332436753, 12200.206986545845, 12226.633201003984, 12233.920233560317, 6627.93372066278, 6874.587524748531, 6878.38094571486, 6891.931080689179, 6894.896576551356, 4046.8785936421955, 4372.584604462571, 4439.600435960747, 4442.178197033559, 4445.488768791598, 1245.3773113443278, 1253.2793643654843, 1280.206272111297, 1297.7988411796186, 1304.3282709404664, 16442.588935276595, 16924.407645732463, 16966.0, 16980.83019169805, 17134.828651713447, 4370.759608221515, 5042.949570504321, 5087.0, 5577.2191893135, 5801.042827933428, 11943.0, 12022.27866328023, 12063.577774778016, 12080.852319029678, 12081.0, 6509.349065093547, 6565.113709649232, 6592.274849766522, 6594.142761440982, 6597.47220222381, 5360.65155764874, 5389.9191512127345, 6038.969805150946, 6049.213602231682, 6661.600303981777, 3707.0547010512687, 3717.312297225022, 4241.363795430649, 4389.473263208435, 4412.22786012453, 1301.3883474766844, 1303.7001489657432, 1311.141202512356, 1311.2984553263957, 1320.7028418605928, 766.3447752171925, 777.6461709921972, 782.4249176855006, 792.8771040488733, 825.3768404854417, 6547.247066587403, 6801.557898736566, 7073.893891591527, 7108.111486064242, 7211.71153153868, 851.1573542193184, 939.5020639061308, 951.7906060666643, 951.8048799995984, 958.3483231402713, 4135.379693046068, 4378.824847006148, 4432.667549933768, 4442.53353397895, 4464.486584042812, 15113.3199006045, 15495.535133946, 15507.147106909228, 15623.14072726011, 15623.3750649975, 14739.852601473847, 15292.847071529142, 15398.46105386306, 15432.305546250445, 15556.533304000672, 7498.887516687363, 8654.913450865537, 8830.91169088301, 8896.154865287788, 8903.109689031045, 5638.7462564185535, 6280.277768056732, 6936.653167341512, 7147.821304467222, 7237.276272372931, 10797.62208322705, 11072.280301780358, 12639.0, 13183.274919879499, 13454.394552245369, 13316.533921312708, 13481.797773033217, 13566.118202316818, 13627.250501222132, 13956.09285396446, 9350.625974960925, 9511.906130795047, 9576.904230957602, 9622.085901839315, 9634.181094607036, 10861.78276434451, 10884.727881803019, 10924.235303528994, 10950.288231264942, 10986.890131098906, 9119.908800911906, 9272.629094836131, 9299.0, 9347.485888276211, 9402.95298523503, 9053.728388148365, 9155.633774648939, 9211.585478653342, 9227.984921658746, 9300.162985331353, 8259.297959673495, 8262.297704694927, 8363.03825060126, 8370.790730231793, 8372.288355489607, 5967.283925928917, 6075.908861366995, 6179.69101544912, 6210.378962103753, 6262.279837818709, 6139.907901381573, 6194.659293738888, 6304.117423560797, 6318.08387783778, 6353.0152826312], "value": 5437.906118486007, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.91410061585225, 406.54263953052805, 408.9631933126018, 409.2919249698022, 417.04704749647084, 5667.696429821143, 6031.0, 6437.259715132761, 6438.871222575545, 6450.967745161273, 5672.290963629546, 6076.392360763922, 6080.452759251666, 6235.220597425322, 6266.216722909637, 4722.598579120779, 4741.857744267669, 4748.7863046163, 4768.427788665365, 4768.618510519167, 3978.6220309070736, 4322.84870029549, 4761.90476190476, 4803.18345881201, 4817.445993710716, 4227.577242275764, 4446.622037126848, 4454.309582014776, 4472.0, 4475.462944446655, 4447.977760111211, 4457.331400289966, 4464.285714285715, 4487.6634252431195, 4503.48209955856, 3754.4180651998986, 3832.9616703833162, 3834.827432765532, 3835.86574469895, 3846.4999550058315, 5468.562514998791, 5520.806771762969, 6116.724747386378, 6122.571420000601, 6237.34507876671, 5363.704996225206, 5374.435684253175, 5376.435474275223, 5391.81128660495, 5415.404305526389, 5803.970980145073, 6399.200099987502, 6591.340865913418, 6670.566413183127, 6785.830354241134, 4794.9280760788615, 4837.588804951583, 4853.587445067174, 4853.611711063107, 4884.3161957326, 6095.6952152392205, 6431.614103153779, 6666.833329166761, 6809.829754256134, 7137.964310178468, 4162.812673429703, 4792.640551958547, 4952.504749525018, 4960.776765045582, 4960.975195124073, 4626.558503836355, 4680.695754775928, 5044.369453818273, 5051.0, 5130.79476820923, 5509.201165830932, 5616.550675945915, 5658.943410565842, 5671.404502527258, 5719.942800572025, 6716.764913228014, 6718.7312507499155, 6764.4926630502905, 6790.32096790317, 6807.4894382921475, 1635.7568248131506, 1654.7269700499523, 1713.7258038713994, 1725.1374312843577, 1751.1419404491962, 1165.906727461801, 1204.0193881065773, 1206.6922934651607, 1216.671498695365, 1221.3770976801718, 5827.59206855516, 6233.657148856856, 6424.357564243538, 6451.838704032437, 6455.289918109004, 6467.611943283418, 6757.763478278237, 6863.725450981905, 6963.268856770068, 7053.224145344008, 5991.4907232884825, 6097.298810636745, 6381.150325752369, 6381.500347418353, 6433.359493329264, 3010.3377257003426, 3462.8614855406004, 3551.2897420516, 3628.673419392215, 3628.800415977094, 6268.247810262797, 7085.043519124955, 7154.964225178841, 7162.92837071633, 7179.712811487587, 5893.381194974551, 6283.465905398001, 6880.380765731108, 6998.790036298919, 7156.570605763671, 7160.176579693298, 7184.46116541251, 7211.639418029183, 7212.423006159494, 7228.168760592494, 6317.115603815378, 6590.912499437539, 6631.204255489372, 6914.0666010088, 7022.367986881, 6865.656717164022, 6870.175578930561, 6890.483213758888, 6892.0, 6893.586384816726, 6967.79096627102, 7059.117610298713, 7078.43372530186, 7182.773340264534, 7199.424046076406, 4374.759388233678, 4381.715188512737, 4388.61758546057, 4398.934015989698, 4419.867403977886, 6835.58986460814, 6972.942981820476, 7014.123234595676, 7037.225905150327, 7087.893681594677, 5565.858998905133, 6418.261899881573, 6582.308857569887, 6659.304086232188, 6666.400023997863, 6015.5488338373925, 6108.816735497942, 6526.184226971629, 6644.900326495203, 6672.366125218096, 5687.744051517774, 5777.8555536111935, 6151.9234134027265, 6375.234971803413, 6508.479321654351, 5081.415637201769, 6615.702293396905, 6692.564983276072, 6697.497687673346, 6753.15585551806, 5609.997302885873, 6456.386643268882, 6466.900626893345, 6525.575837570543, 6569.343065693392], "value": 4935.307916339741, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [776.712616331957, 778.8987431633889, 839.9664013439462, 846.2891171416013, 885.6103314541604, 16667.24997375118, 17093.999999999985, 17146.82853171468, 18479.722804157915, 19172.904135479337, 17930.55173620657, 18371.72442413365, 18377.897326160408, 18547.35084272051, 18574.442766716988, 988.7577543501852, 988.7676396046924, 1007.028217769852, 1010.4038617215841, 1011.6155860772933, 1009.7374682582545, 1012.997132838492, 1013.8681971343752, 1018.1091544898214, 1018.2821111116682, 1066.6906597086875, 1073.3023534702427, 1074.5970261152067, 1077.6659235636978, 1080.1089101491302, 883.2007033634507, 1068.9305195162328, 1075.5428942699361, 1075.5912753153752, 1076.3111608570482, 758.2720588235301, 768.3123604374053, 768.4774353439659, 769.8383339498712, 787.016229712859, 15869.52391428259, 17128.657426851518, 17209.311627534884, 17340.47978560645, 17410.825891741046, 17122.0, 17374.652506949915, 17523.912380438145, 17534.561635959075, 17565.121743912754, 13612.455501780016, 13950.790738138936, 14089.225092619901, 14229.501967431193, 14252.287385630782, 3483.372992861284, 3542.3800834853796, 3543.6633519815578, 3547.929041419183, 3555.768875023141, 113764.99999999917, 133752.0, 133912.0, 135990.0, 136877.0, 12620.17968832023, 12812.55156069533, 13514.526991555249, 13564.457421703219, 13677.179369237878, 21720.674189887166, 25162.119325823875, 25492.8725356372, 25762.742372576035, 25829.3542661435, 6087.29996050451, 6842.007908853188, 7198.5320954137815, 7521.0, 7588.772336829904, 3002.429538387743, 3718.330700473941, 3739.775613463201, 3742.9625703742613, 3743.1390780120723, 3740.756850804689, 4274.871753847327, 4407.228734971367, 4435.645148388121, 4440.4005459263235, 940.9294302927308, 951.900050494702, 953.2564599612314, 968.2931460034215, 970.1850445625709, 611.9871612481351, 645.319188256394, 651.8044586623994, 653.1541653558653, 691.7544271783545, 10872.0, 11461.770764584662, 11778.234414763014, 12061.638150855313, 12122.27266364021, 616.6392660293689, 635.8664680417164, 640.5676168586185, 662.4667142949875, 679.67035987546, 4713.222318317507, 5111.7699703513435, 5356.250124982505, 5529.087700529448, 5668.0647693130995, 83147.0, 85118.0, 109955.0, 113060.0, 119507.0, 92250.53874730718, 92559.0, 93535.90168186338, 93730.53134734283, 94878.0, 81481.59259203548, 88113.91601294052, 89172.0, 89227.21545569182, 90775.54612226896, 12065.034797216376, 12631.0, 13051.804222936853, 13064.412101455267, 13156.407961641558, 34676.65323346835, 39861.80069099636, 41385.79307103445, 41972.48165110103, 42104.78947605242, 74306.0, 74406.0, 75665.0, 76722.08194795175, 78053.0, 16601.750973735645, 16812.663746724753, 16923.492295231164, 17007.659846802748, 17031.914840425718, 16982.320707171573, 16990.895591786495, 17838.464846054638, 18489.90755046216, 18914.810851891303, 13976.0, 14602.707945841235, 16718.331266749195, 16779.664406712043, 17204.225809838335, 16648.334066637683, 16820.90664106829, 16936.068516231724, 17063.40278090261, 17105.572360691083, 13639.659008524866, 16070.839291606935, 16136.503707827025, 16195.0, 16460.0, 9946.502674866084, 11664.88335116638, 11977.580784672495, 12204.206726562745, 12222.449989750305, 12497.0, 12704.237745735285, 12992.480300787862, 13317.933410332886, 13347.66630834237], "value": 8463.268102577453, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1547.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 117.0, 112.0, 113.0, 116.0, 112.0, 114.0, 114.0, 114.0, 129.0], "value": 114.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 122.0, 143.0, 181.0, 136.0, 112.0, 110.0, 113.0, 138.0, 110.0], "value": 129.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [225.0, 197.0, 203.0, 246.0, 242.0, 250.0, 253.0, 286.0, 212.0, 201.0], "value": 231.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 59.0, 57.0, 81.0, 57.0, 58.0, 59.0, 52.0, 78.0, 66.0], "value": 64.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 71.0, 81.0, 72.0, 73.0, 70.0, 104.0, 103.0, 84.0, 92.0], "value": 83.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 92.0, 90.0, 89.0, 90.0, 89.0, 103.0, 88.0, 89.0, 89.0], "value": 90.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 125.0, 103.0, 153.0, 97.0, 97.0, 97.0, 98.0, 97.0, 105.0], "value": 106.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 96.0, 91.0, 136.0, 148.0, 92.0, 93.0, 87.0, 93.0, 92.0], "value": 101.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 50.0, 49.0, 50.0, 52.0, 51.0, 51.0, 50.0, 65.0, 51.0], "value": 51.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 60.0, 67.0, 64.0, 64.0, 63.0, 59.0, 54.0, 55.0, 70.0], "value": 61.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 81.0, 83.0, 84.0, 84.0, 82.0, 82.0, 83.0, 86.0, 82.0], "value": 83.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 137.0, 141.0, 127.0, 154.0, 149.0, 149.0, 158.0, 187.0, 139.0], "value": 147.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 216.0, 199.0, 223.0, 235.0, 204.0, 221.0, 194.0, 190.0, 189.0], "value": 205.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 67.0, 87.0, 94.0, 80.0, 66.0, 68.0, 66.0, 70.0], "value": 73.5, "unit": "score"}]}]} 19:47:41 INFO - Return code: 0 19:47:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:47:41 ERROR - # TBPL SUCCESS # 19:47:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:47:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:47:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:47:41 INFO - 2017-04-26 19:47:41.906 screenresolution[1656:10867] starting screenresolution argv=screenresolution get 19:47:41 INFO - 2017-04-26 19:47:41.908 screenresolution[1656:10867] Display 0: 1600x1200x32@60 19:47:41 INFO - 2017-04-26 19:47:41.914 screenresolution[1657:10870] starting screenresolution argv=screenresolution list 19:47:41 INFO - Available Modes on Display 0 19:47:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:47:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:47:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:47:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:47:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:47:42 INFO - Intel Iris: 19:47:42 INFO - Chipset Model: Intel Iris 19:47:42 INFO - Type: GPU 19:47:42 INFO - Bus: Built-In 19:47:42 INFO - VRAM (Dynamic, Max): 1536 MB 19:47:42 INFO - Vendor: Intel (0x8086) 19:47:42 INFO - Device ID: 0x0a2e 19:47:42 INFO - Revision ID: 0x0009 19:47:42 INFO - Displays: 19:47:42 INFO - Display: 19:47:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:47:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:47:42 INFO - Display Serial Number: 1600x1200 60 19:47:42 INFO - Main Display: Yes 19:47:42 INFO - Mirror: Off 19:47:42 INFO - Online: Yes 19:47:42 INFO - Rotation: Supported 19:47:42 INFO - Return code: 0 19:47:42 INFO - Running post-action listener: _resource_record_post_action 19:47:42 INFO - [mozharness: 2017-04-27 02:47:42.151320Z] Finished run-tests step (success) 19:47:42 INFO - Running post-run listener: _resource_record_post_run 19:47:42 INFO - Total resource usage - Wall time: 1198s; CPU: 54.0%; Read bytes: 40270336; Write bytes: 511929344; Read time: 393; Write time: 2030 19:47:42 INFO - TinderboxPrint: CPU usage
54.2% 19:47:42 INFO - TinderboxPrint: I/O read bytes / time
40,270,336 / 393 19:47:42 INFO - TinderboxPrint: I/O write bytes / time
511,929,344 / 2,030 19:47:42 INFO - TinderboxPrint: CPU idle
2,195.6 (45.8%) 19:47:42 INFO - TinderboxPrint: CPU system
962.1 (20.1%) 19:47:42 INFO - TinderboxPrint: CPU user
1,635.9 (34.1%) 19:47:42 INFO - TinderboxPrint: Swap in / out
248,340,480 / 0 19:47:42 INFO - install - Wall time: 20s; CPU: 55.0%; Read bytes: 211257856; Write bytes: 206263808; Read time: 16101; Write time: 415 19:47:42 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 33010176; Write bytes: 298636800; Read time: 303; Write time: 1586 19:47:42 INFO - Running post-run listener: _upload_blobber_files 19:47:42 INFO - Blob upload gear active. 19:47:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:47: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 19:47: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'] 19:47: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 19:47:43 INFO - (blobuploader) - INFO - Open directory for files ... 19:47:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:47:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:47:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:47:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:47:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:47:44 INFO - (blobuploader) - INFO - Done attempting. 19:47:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:47:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:47:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:47:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:47:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:47:45 INFO - (blobuploader) - INFO - Done attempting. 19:47:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:47:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:47:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:47:46 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:47:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:47:46 INFO - (blobuploader) - INFO - Done attempting. 19:47:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:47:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:47:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:47:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:47:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:47:48 INFO - (blobuploader) - INFO - Done attempting. 19:47:48 INFO - (blobuploader) - INFO - Iteration through files over. 19:47:48 INFO - Return code: 0 19:47:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:47:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:47:48 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/159224b60d04878f8a4e6c21748e1ced8a2360bbe6e1d1826f6111ff950787c78f519f2236ac14af78ebb408fdc809e4afd6c210f3fe1b478c48319f6fb90691", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5369a67abcb034dc4fe41f6a297eaeee177d27194e5e055f8d982dd3947ad850033fe03b3c64649c078470a945df52e65e10c8ac0fa858ae4be2e934a3f5a3cc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7d30d1ce4326d04962e1ce7d96392f6ad6e7c696223909c7042a39ad0d6567f6483d7aeb2fb02370962270205f4b7ea342bf0fc3b21e7ece50244d6387eec6ba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/162f740e77b377ce49786b11d42fd6bbc4dcd3b4706f02c1295a12923e9d55ad0e5fa0cbc4529b801735e7679f375c8b3e9ec3c171026e0174ebc66fa57b2d84"} 19:47:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:47:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:47:48 INFO - Contents: 19:47:48 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/159224b60d04878f8a4e6c21748e1ced8a2360bbe6e1d1826f6111ff950787c78f519f2236ac14af78ebb408fdc809e4afd6c210f3fe1b478c48319f6fb90691", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5369a67abcb034dc4fe41f6a297eaeee177d27194e5e055f8d982dd3947ad850033fe03b3c64649c078470a945df52e65e10c8ac0fa858ae4be2e934a3f5a3cc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7d30d1ce4326d04962e1ce7d96392f6ad6e7c696223909c7042a39ad0d6567f6483d7aeb2fb02370962270205f4b7ea342bf0fc3b21e7ece50244d6387eec6ba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/162f740e77b377ce49786b11d42fd6bbc4dcd3b4706f02c1295a12923e9d55ad0e5fa0cbc4529b801735e7679f375c8b3e9ec3c171026e0174ebc66fa57b2d84"} 19:47:48 INFO - Running post-run listener: copy_logs_to_upload_dir 19:47:48 INFO - Copying logs to upload dir... 19:47:48 INFO - mkdir: /builds/slave/test/build/upload/logs 19:47:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1283.706296 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-04-26 19:47:48.326054) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-26 19:47:48.329687) ========= 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.rXZ1VnZtE8/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.KVZ2zQzB5E/Listeners TMPDIR=/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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/159224b60d04878f8a4e6c21748e1ced8a2360bbe6e1d1826f6111ff950787c78f519f2236ac14af78ebb408fdc809e4afd6c210f3fe1b478c48319f6fb90691", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5369a67abcb034dc4fe41f6a297eaeee177d27194e5e055f8d982dd3947ad850033fe03b3c64649c078470a945df52e65e10c8ac0fa858ae4be2e934a3f5a3cc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7d30d1ce4326d04962e1ce7d96392f6ad6e7c696223909c7042a39ad0d6567f6483d7aeb2fb02370962270205f4b7ea342bf0fc3b21e7ece50244d6387eec6ba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/162f740e77b377ce49786b11d42fd6bbc4dcd3b4706f02c1295a12923e9d55ad0e5fa0cbc4529b801735e7679f375c8b3e9ec3c171026e0174ebc66fa57b2d84"} build_url:https://queue.taskcluster.net/v1/task/SPPAXnQGTfiYvz95qtdmLQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011037 build_url: 'https://queue.taskcluster.net/v1/task/SPPAXnQGTfiYvz95qtdmLQ/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/159224b60d04878f8a4e6c21748e1ced8a2360bbe6e1d1826f6111ff950787c78f519f2236ac14af78ebb408fdc809e4afd6c210f3fe1b478c48319f6fb90691", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5369a67abcb034dc4fe41f6a297eaeee177d27194e5e055f8d982dd3947ad850033fe03b3c64649c078470a945df52e65e10c8ac0fa858ae4be2e934a3f5a3cc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7d30d1ce4326d04962e1ce7d96392f6ad6e7c696223909c7042a39ad0d6567f6483d7aeb2fb02370962270205f4b7ea342bf0fc3b21e7ece50244d6387eec6ba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/162f740e77b377ce49786b11d42fd6bbc4dcd3b4706f02c1295a12923e9d55ad0e5fa0cbc4529b801735e7679f375c8b3e9ec3c171026e0174ebc66fa57b2d84"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-26 19:47:48.365258) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-26 19:47:48.365577) ========= 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.rXZ1VnZtE8/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.KVZ2zQzB5E/Listeners TMPDIR=/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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.005046 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-26 19:47:48.414193) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-26 19:47:48.414516) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-26 19:47:48.414835) ========= ========= Total master_lag: 0.19 =========