builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0188 starttime: 1490142035.73 results: success (0) buildid: 20170321160934 builduid: 55c1e09a32204164bbc0ae7466603b0d revision: 8744e9f8eb99f1290aae81985812d57364f18708 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-21 17:20:35.729353) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-21 17:20:35.729784) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-21 17:20:35.730064) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-21 17:20:35.833626) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 17:20:35.833932) ========= 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.imdrghlOgd/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.YnZopf76ot/Listeners TMPDIR=/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-21 17:20:35-- 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% 30.0M=0s 2017-03-21 17:20:36 (30.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.405952 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 17:20:36.264478) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 17:20:36.264797) ========= 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.imdrghlOgd/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.YnZopf76ot/Listeners TMPDIR=/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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.028569 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 17:20:36.316089) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 17:20:36.316523) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8744e9f8eb99f1290aae81985812d57364f18708 --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 8744e9f8eb99f1290aae81985812d57364f18708 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.imdrghlOgd/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.YnZopf76ot/Listeners TMPDIR=/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-21 17:20:36,471 truncating revision to first 12 chars 2017-03-21 17:20:36,471 Setting DEBUG logging. 2017-03-21 17:20:36,471 attempt 1/10 2017-03-21 17:20:36,471 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8744e9f8eb99?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-21 17:20:37,105 unpacking tar archive at: mozilla-central-8744e9f8eb99/testing/mozharness/ program finished with exit code 0 elapsedTime=0.907867 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 17:20:37.248403) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-21 17:20:37.248771) ========= script_repo_revision: 8744e9f8eb99f1290aae81985812d57364f18708 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-21 17:20:37.249182) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-21 17:20:37.249463) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-21 17:20:37.266969) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-03-21 17:20:37.267379) ========= /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.imdrghlOgd/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.YnZopf76ot/Listeners TMPDIR=/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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 17:20:37 INFO - MultiFileLogger online at 20170321 17:20:37 in /builds/slave/test 17:20:37 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 17:20:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:20:37 INFO - {'append_to_log': False, 17:20:37 INFO - 'base_work_dir': '/builds/slave/test', 17:20:37 INFO - 'blob_upload_branch': 'Firefox', 17:20:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:20:37 INFO - 'branch': 'Firefox', 17:20:37 INFO - 'buildbot_json_path': 'buildprops.json', 17:20:37 INFO - 'config_files': ('talos/mac_config.py',), 17:20:37 INFO - 'default_actions': ('clobber', 17:20:37 INFO - 'read-buildbot-config', 17:20:37 INFO - 'download-and-extract', 17:20:37 INFO - 'populate-webroot', 17:20:37 INFO - 'create-virtualenv', 17:20:37 INFO - 'install', 17:20:37 INFO - 'run-tests'), 17:20:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:20:37 INFO - 'download_minidump_stackwalk': True, 17:20:37 INFO - 'download_symbols': 'ondemand', 17:20:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:20:37 INFO - 'tooltool.py': '/tools/tooltool.py', 17:20:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:20:37 INFO - '/tools/misc-python/virtualenv.py')}, 17:20:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:20:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:20:37 INFO - 'gecko_profile': False, 17:20:37 INFO - 'gecko_profile_interval': 0, 17:20:37 INFO - 'installer_path': 'installer.exe', 17:20:37 INFO - 'log_level': 'info', 17:20:37 INFO - 'log_name': 'talos', 17:20:37 INFO - 'log_to_console': True, 17:20:37 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:20:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:20:37 INFO - 'opt_config_files': (), 17:20:37 INFO - 'pip_index': False, 17:20:37 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:20:37 INFO - 'cmd': ('bash', 17:20:37 INFO - '-c', 17:20:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:20:37 INFO - 'enabled': True, 17:20:37 INFO - 'halt_on_failure': False, 17:20:37 INFO - 'name': 'check_screen_resolution'},), 17:20:37 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:20:37 INFO - 'cmd': ('bash', 17:20:37 INFO - '-c', 17:20:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:20:37 INFO - 'enabled': True, 17:20:37 INFO - 'halt_on_failure': False, 17:20:37 INFO - 'name': 'check_screen_resolution'},), 17:20:37 INFO - 'run_cmd_checks_enabled': True, 17:20:37 INFO - 'suite': 'dromaeojs-e10s', 17:20:37 INFO - 'system_bits': '32', 17:20:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:20:37 INFO - 'title': 't-yosemite-r7-0188', 17:20:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:20:37 INFO - 'use_talos_json': True, 17:20:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:20:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:20:37 INFO - 'work_dir': 'build'} 17:20:37 INFO - [mozharness: 2017-03-22 00:20:37.536835Z] Running clobber step. 17:20:37 INFO - Running pre-action listener: _resource_record_pre_action 17:20:37 INFO - Running main action method: clobber 17:20:37 INFO - rmtree: /builds/slave/test/build 17:20:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:20:39 INFO - Running post-action listener: _resource_record_post_action 17:20:39 INFO - [mozharness: 2017-03-22 00:20:39.989543Z] Finished clobber step (success) 17:20:39 INFO - [mozharness: 2017-03-22 00:20:39.989694Z] Running read-buildbot-config step. 17:20:39 INFO - Running pre-action listener: _resource_record_pre_action 17:20:39 INFO - Running main action method: read_buildbot_config 17:20:39 INFO - Using buildbot properties: 17:20:39 INFO - { 17:20:39 INFO - "project": "", 17:20:39 INFO - "product": "firefox", 17:20:39 INFO - "script_repo_revision": "production", 17:20:39 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 17:20:39 INFO - "repository": "", 17:20:39 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 17:20:39 INFO - "buildid": "20170321160934", 17:20:39 INFO - "pgo_build": "False", 17:20:39 INFO - "basedir": "/builds/slave/test", 17:20:39 INFO - "buildnumber": 0, 17:20:39 INFO - "slavename": "t-yosemite-r7-0188", 17:20:39 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 17:20:39 INFO - "platform": "yosemite_r7", 17:20:39 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 17:20:39 INFO - "branch": "mozilla-central", 17:20:39 INFO - "repo_path": "mozilla-central", 17:20:39 INFO - "revision": "8744e9f8eb99f1290aae81985812d57364f18708", 17:20:39 INFO - "stage_platform": "macosx64", 17:20:39 INFO - "builduid": "55c1e09a32204164bbc0ae7466603b0d", 17:20:39 INFO - "slavebuilddir": "test" 17:20:39 INFO - } 17:20:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/bzwaR3AHTROGsrH592UvYA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 17:20:39 INFO - Running post-action listener: _resource_record_post_action 17:20:39 INFO - [mozharness: 2017-03-22 00:20:39.993055Z] Finished read-buildbot-config step (success) 17:20:39 INFO - [mozharness: 2017-03-22 00:20:39.993192Z] Running download-and-extract step. 17:20:39 INFO - Running pre-action listener: _resource_record_pre_action 17:20:39 INFO - Running main action method: download_and_extract 17:20:39 INFO - mkdir: /builds/slave/test/build/tests 17:20:39 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')]} 17:20:39 INFO - trying https://queue.taskcluster.net/v1/task/bzwaR3AHTROGsrH592UvYA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 17:20:39 INFO - Downloading https://queue.taskcluster.net/v1/task/bzwaR3AHTROGsrH592UvYA/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 17:20:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bzwaR3AHTROGsrH592UvYA/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 17:20:41 INFO - Downloaded 1325 bytes. 17:20:41 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 17:20:41 INFO - Using the following test package requirements: 17:20:41 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:20:41 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 17:20:41 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 17:20:41 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:20:41 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 17:20:41 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:20:41 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 17:20:41 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:20:41 INFO - u'jsshell-mac.zip'], 17:20:41 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:20:41 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 17:20:41 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 17:20:41 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:20:41 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 17:20:41 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:20:41 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 17:20:41 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:20:41 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 17:20:41 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:20:41 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 17:20:41 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:20:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bzwaR3AHTROGsrH592UvYA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 17:20:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bzwaR3AHTROGsrH592UvYA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:20:41 INFO - Fetch https://queue.taskcluster.net/v1/task/bzwaR3AHTROGsrH592UvYA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 17:20:42 INFO - Expected file size: 52477569 17:20:42 INFO - Obtained file size: 52477569 17:20:59 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 17:20:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bzwaR3AHTROGsrH592UvYA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 17:20:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bzwaR3AHTROGsrH592UvYA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:20:59 INFO - Fetch https://queue.taskcluster.net/v1/task/bzwaR3AHTROGsrH592UvYA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 17:21:01 INFO - Expected file size: 52477569 17:21:01 INFO - Obtained file size: 52477569 17:21:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bzwaR3AHTROGsrH592UvYA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 17:21:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bzwaR3AHTROGsrH592UvYA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 17:21:16 INFO - Fetch https://queue.taskcluster.net/v1/task/bzwaR3AHTROGsrH592UvYA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 17:21:17 INFO - Expected file size: 14404171 17:21:17 INFO - Obtained file size: 14404171 17:21:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:21:17 INFO - trying https://queue.taskcluster.net/v1/task/bzwaR3AHTROGsrH592UvYA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 17:21:17 INFO - Downloading https://queue.taskcluster.net/v1/task/bzwaR3AHTROGsrH592UvYA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 17:21:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bzwaR3AHTROGsrH592UvYA/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 17:21:19 INFO - Downloaded 75279508 bytes. 17:21:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bzwaR3AHTROGsrH592UvYA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 17:21:19 INFO - mkdir: /builds/slave/test/properties 17:21:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:21:19 INFO - Writing to file /builds/slave/test/properties/build_url 17:21:19 INFO - Contents: 17:21:19 INFO - build_url:https://queue.taskcluster.net/v1/task/bzwaR3AHTROGsrH592UvYA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 17:21:21 INFO - Running post-action listener: _resource_record_post_action 17:21:21 INFO - Running post-action listener: set_extra_try_arguments 17:21:21 INFO - [mozharness: 2017-03-22 00:21:21.041482Z] Finished download-and-extract step (success) 17:21:21 INFO - [mozharness: 2017-03-22 00:21:21.041579Z] Running populate-webroot step. 17:21:21 INFO - Running pre-action listener: _resource_record_pre_action 17:21:21 INFO - Running main action method: populate_webroot 17:21:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:21:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:21:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:21:21 INFO - '--tppagecycles', 17:21:21 INFO - '7'], 17:21:21 INFO - 'tests': ['tsvgm']}}, 17:21:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:21:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:21:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:21:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:21:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:21:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:21:21 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:21:21 INFO - 'talos_options': ['--disable-e10s'], 17:21:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:21:21 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:21:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:21:21 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:21:21 INFO - 'talos_options': ['--disable-e10s'], 17:21:21 INFO - 'tests': ['damp', 'tps']}, 17:21:21 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:21:21 INFO - 'tests': ['damp', 'tps']}, 17:21:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:21:21 INFO - 'tests': ['dromaeo_dom']}, 17:21:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:21:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:21:21 INFO - 'tests': ['basic_compositor_video']}, 17:21:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:21:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:21:21 INFO - 'tests': ['a11yr', 17:21:21 INFO - 'ts_paint', 17:21:21 INFO - 'tpaint', 17:21:21 INFO - 'sessionrestore', 17:21:21 INFO - 'sessionrestore_no_auto_restore', 17:21:21 INFO - 'tabpaint']}, 17:21:21 INFO - 'other-e10s': {'tests': ['a11yr', 17:21:21 INFO - 'ts_paint', 17:21:21 INFO - 'tpaint', 17:21:21 INFO - 'sessionrestore', 17:21:21 INFO - 'sessionrestore_no_auto_restore', 17:21:21 INFO - 'tabpaint']}, 17:21:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:21:21 INFO - 'ts_paint', 17:21:21 INFO - 'tpaint', 17:21:21 INFO - 'sessionrestore', 17:21:21 INFO - 'sessionrestore_no_auto_restore', 17:21:21 INFO - 'tabpaint']}, 17:21:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:21:21 INFO - 'ts_paint', 17:21:21 INFO - 'tpaint', 17:21:21 INFO - 'sessionrestore', 17:21:21 INFO - 'sessionrestore_no_auto_restore', 17:21:21 INFO - 'tabpaint']}, 17:21:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:21:21 INFO - 'tests': ['a11yr', 17:21:21 INFO - 'ts_paint', 17:21:21 INFO - 'tpaint', 17:21:21 INFO - 'sessionrestore', 17:21:21 INFO - 'sessionrestore_no_auto_restore', 17:21:21 INFO - 'tabpaint']}, 17:21:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:21:21 INFO - 'tests': ['a11yr', 17:21:21 INFO - 'ts_paint', 17:21:21 INFO - 'tpaint', 17:21:21 INFO - 'sessionrestore', 17:21:21 INFO - 'sessionrestore_no_auto_restore', 17:21:21 INFO - 'tabpaint']}, 17:21:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:21:21 INFO - 'tests': ['tsvgx', 17:21:21 INFO - 'tsvgr_opacity', 17:21:21 INFO - 'tart', 17:21:21 INFO - 'tscrollx', 17:21:21 INFO - 'cart', 17:21:21 INFO - 'tsvg_static']}, 17:21:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:21:21 INFO - 'tsvgr_opacity', 17:21:21 INFO - 'tart', 17:21:21 INFO - 'tscrollx', 17:21:21 INFO - 'cart', 17:21:21 INFO - 'tsvg_static']}, 17:21:21 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:21:21 INFO - 'talos_options': ['--disable-e10s'], 17:21:21 INFO - 'tests': ['tp5o']}, 17:21:21 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:21:21 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:21:21 INFO - 'talos_options': ['--disable-e10s', 17:21:21 INFO - '--xperf_path', 17:21:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:21:21 INFO - 'tests': ['tp5n']}, 17:21:21 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:21:21 INFO - 'talos_options': ['--xperf_path', 17:21:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:21:21 INFO - 'tests': ['tp5n']}}, 17:21:21 INFO - 'talos.zip': {'path': '', 17:21:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:21:21 INFO - Running post-action listener: _resource_record_post_action 17:21:21 INFO - [mozharness: 2017-03-22 00:21:21.059906Z] Finished populate-webroot step (success) 17:21:21 INFO - [mozharness: 2017-03-22 00:21:21.060044Z] Running create-virtualenv step. 17:21:21 INFO - Running pre-action listener: _resource_record_pre_action 17:21:21 INFO - Running main action method: create_virtualenv 17:21:21 INFO - Creating virtualenv /builds/slave/test/build/venv 17:21:21 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 17:21:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:21:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:21:21 INFO - Using real prefix '/tools/python27' 17:21:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:21:21 INFO - Installing distribute.............................................................................................................................................................................................done. 17:21:24 INFO - Installing pip.................done. 17:21:24 INFO - Return code: 0 17:21:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:21:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:21:25 INFO - Reading from file tmpfile_stdout 17:21:25 INFO - Output received: 17:21:25 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) 17:21:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:21:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:21:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:21:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:21:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:21:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bf61b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf64768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed004b58d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd3fd30>, '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 0x10bc66db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd34be8>, '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.imdrghlOgd/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.YnZopf76ot/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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 17:21:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:21:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:21:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.imdrghlOgd/Render', 17:21:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:21:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:21:25 INFO - 'HOME': '/Users/cltbld', 17:21:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:21:25 INFO - 'LOGNAME': 'cltbld', 17:21:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:21:25 INFO - 'MOZ_NO_REMOTE': '1', 17:21:25 INFO - 'NO_EM_RESTART': '1', 17:21:25 INFO - 'PAGER': '/bin/cat', 17:21:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:21:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:21:25 INFO - 'PWD': '/builds/slave/test', 17:21:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:21:25 INFO - 'SHELL': '/bin/bash', 17:21:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YnZopf76ot/Listeners', 17:21:25 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 17:21:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:21:25 INFO - 'USER': 'cltbld', 17:21:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:21:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:21:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:21:25 INFO - 'XPC_FLAGS': '0x0', 17:21:25 INFO - 'XPC_SERVICE_NAME': '0', 17:21:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:21:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:21:25 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 17:21:25 INFO - Cleaning up... 17:21:25 INFO - Return code: 0 17:21:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:21:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:21:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:21:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:21:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:21:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10bf61b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf64768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed004b58d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd3fd30>, '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 0x10bc66db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd34be8>, '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.imdrghlOgd/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.YnZopf76ot/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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 17:21:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:21:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:21:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.imdrghlOgd/Render', 17:21:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:21:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:21:25 INFO - 'HOME': '/Users/cltbld', 17:21:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:21:25 INFO - 'LOGNAME': 'cltbld', 17:21:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:21:25 INFO - 'MOZ_NO_REMOTE': '1', 17:21:25 INFO - 'NO_EM_RESTART': '1', 17:21:25 INFO - 'PAGER': '/bin/cat', 17:21:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:21:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:21:25 INFO - 'PWD': '/builds/slave/test', 17:21:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:21:25 INFO - 'SHELL': '/bin/bash', 17:21:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YnZopf76ot/Listeners', 17:21:25 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 17:21:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:21:25 INFO - 'USER': 'cltbld', 17:21:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:21:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:21:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:21:25 INFO - 'XPC_FLAGS': '0x0', 17:21:25 INFO - 'XPC_SERVICE_NAME': '0', 17:21:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:21:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:21:25 INFO - Downloading/unpacking psutil>=3.1.1 17:21:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:21:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:21:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:21:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:21:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:21:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:21:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:21:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:21:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:21:29 INFO - Installing collected packages: psutil 17:21:29 INFO - Running setup.py install for psutil 17:21:29 INFO - building 'psutil._psutil_osx' extension 17:21:29 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 17:21:30 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 17:21:30 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 17:21:30 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 17:21:30 INFO - building 'psutil._psutil_posix' extension 17:21:30 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 17:21:30 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:21:30 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:21:30 INFO - ^ 17:21:30 INFO - 1 warning generated. 17:21:30 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 17:21:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:21:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:21:30 INFO - Successfully installed psutil 17:21:30 INFO - Cleaning up... 17:21:31 INFO - Return code: 0 17:21:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:21:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:21:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:21:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:21:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:21:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:31 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 0x10bf61b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf64768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed004b58d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd3fd30>, '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 0x10bc66db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd34be8>, '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.imdrghlOgd/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.YnZopf76ot/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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 17:21:31 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 17:21:31 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 17:21:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.imdrghlOgd/Render', 17:21:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:21:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:21:31 INFO - 'HOME': '/Users/cltbld', 17:21:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:21:31 INFO - 'LOGNAME': 'cltbld', 17:21:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:21:31 INFO - 'MOZ_NO_REMOTE': '1', 17:21:31 INFO - 'NO_EM_RESTART': '1', 17:21:31 INFO - 'PAGER': '/bin/cat', 17:21:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:21:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:21:31 INFO - 'PWD': '/builds/slave/test', 17:21:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:21:31 INFO - 'SHELL': '/bin/bash', 17:21:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YnZopf76ot/Listeners', 17:21:31 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 17:21:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:21:31 INFO - 'USER': 'cltbld', 17:21:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:21:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:21:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:21:31 INFO - 'XPC_FLAGS': '0x0', 17:21:31 INFO - 'XPC_SERVICE_NAME': '0', 17:21:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:21:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:21:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:21:31 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 17:21:31 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 17:21:31 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 17:21:31 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 17:21:31 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 17:21:31 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 17:21:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:21:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:21:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:21:34 INFO - Installing collected packages: mozsystemmonitor 17:21:34 INFO - Running setup.py install for mozsystemmonitor 17:21:34 INFO - Successfully installed mozsystemmonitor 17:21:34 INFO - Cleaning up... 17:21:34 INFO - Return code: 0 17:21:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:21:34 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')]} 17:21:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:21:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:34 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')]} 17:21:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:21:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:34 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 0x10bf61b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf64768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed004b58d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd3fd30>, '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 0x10bc66db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd34be8>, '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.imdrghlOgd/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.YnZopf76ot/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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 17:21:34 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 17:21:34 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 17:21:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.imdrghlOgd/Render', 17:21:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:21:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:21:34 INFO - 'HOME': '/Users/cltbld', 17:21:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:21:34 INFO - 'LOGNAME': 'cltbld', 17:21:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:21:34 INFO - 'MOZ_NO_REMOTE': '1', 17:21:34 INFO - 'NO_EM_RESTART': '1', 17:21:34 INFO - 'PAGER': '/bin/cat', 17:21:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:21:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:21:34 INFO - 'PWD': '/builds/slave/test', 17:21:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:21:34 INFO - 'SHELL': '/bin/bash', 17:21:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YnZopf76ot/Listeners', 17:21:34 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 17:21:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:21:34 INFO - 'USER': 'cltbld', 17:21:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:21:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:21:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:21:34 INFO - 'XPC_FLAGS': '0x0', 17:21:34 INFO - 'XPC_SERVICE_NAME': '0', 17:21:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:21:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:21:34 INFO - Downloading/unpacking jsonschema==2.5.1 17:21:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:21:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:21:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:21:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:21:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:21:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:21:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:21:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:21:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:21:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:21:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:21:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:21:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:21:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:21:37 INFO - Downloading functools32-3.2.3-2.tar.gz 17:21:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:21:37 INFO - warning: no files found matching '*.txt' 17:21:37 INFO - no previously-included directories found matching 'build' 17:21:37 INFO - no previously-included directories found matching 'dist' 17:21:37 INFO - no previously-included directories found matching '.git*' 17:21:37 INFO - Installing collected packages: jsonschema, functools32 17:21:37 INFO - Running setup.py install for functools32 17:21:37 INFO - warning: no files found matching '*.txt' 17:21:37 INFO - no previously-included directories found matching 'build' 17:21:37 INFO - no previously-included directories found matching 'dist' 17:21:37 INFO - no previously-included directories found matching '.git*' 17:21:37 INFO - Successfully installed jsonschema functools32 17:21:37 INFO - Cleaning up... 17:21:37 INFO - Return code: 0 17:21:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:21: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')]} 17:21:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:21:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21: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')]} 17:21:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:21:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10bf61b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf64768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed004b58d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd3fd30>, '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 0x10bc66db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd34be8>, '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.imdrghlOgd/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.YnZopf76ot/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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 17:21:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:21:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:21:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.imdrghlOgd/Render', 17:21:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:21:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:21:37 INFO - 'HOME': '/Users/cltbld', 17:21:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:21:37 INFO - 'LOGNAME': 'cltbld', 17:21:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:21:37 INFO - 'MOZ_NO_REMOTE': '1', 17:21:37 INFO - 'NO_EM_RESTART': '1', 17:21:37 INFO - 'PAGER': '/bin/cat', 17:21:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:21:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:21:37 INFO - 'PWD': '/builds/slave/test', 17:21:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:21:37 INFO - 'SHELL': '/bin/bash', 17:21:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YnZopf76ot/Listeners', 17:21:37 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 17:21:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:21:37 INFO - 'USER': 'cltbld', 17:21:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:21:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:21:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:21:37 INFO - 'XPC_FLAGS': '0x0', 17:21:37 INFO - 'XPC_SERVICE_NAME': '0', 17:21:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:21:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:21:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:21:38 INFO - Cleaning up... 17:21:38 INFO - Return code: 0 17:21:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:21:38 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')]} 17:21:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:21:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:38 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')]} 17:21:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:21:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:38 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 0x10bf61b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf64768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed004b58d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd3fd30>, '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 0x10bc66db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd34be8>, '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.imdrghlOgd/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.YnZopf76ot/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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 17:21:38 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 17:21:38 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 17:21:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.imdrghlOgd/Render', 17:21:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:21:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:21:38 INFO - 'HOME': '/Users/cltbld', 17:21:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:21:38 INFO - 'LOGNAME': 'cltbld', 17:21:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:21:38 INFO - 'MOZ_NO_REMOTE': '1', 17:21:38 INFO - 'NO_EM_RESTART': '1', 17:21:38 INFO - 'PAGER': '/bin/cat', 17:21:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:21:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:21:38 INFO - 'PWD': '/builds/slave/test', 17:21:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:21:38 INFO - 'SHELL': '/bin/bash', 17:21:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YnZopf76ot/Listeners', 17:21:38 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 17:21:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:21:38 INFO - 'USER': 'cltbld', 17:21:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:21:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:21:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:21:38 INFO - 'XPC_FLAGS': '0x0', 17:21:38 INFO - 'XPC_SERVICE_NAME': '0', 17:21:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:21:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:21:38 INFO - Downloading/unpacking blobuploader==1.2.4 17:21:38 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 17:21:38 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 17:21:38 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 17:21:38 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 17:21:38 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 17:21:38 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 17:21:41 INFO - Downloading blobuploader-1.2.4.tar.gz 17:21:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:21:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:21:41 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 17:21:41 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 17:21:41 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 17:21:41 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 17:21:41 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 17:21:41 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 17:21:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:21:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:21:41 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 17:21:41 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 17:21:41 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 17:21:41 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 17:21:41 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 17:21:41 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 17:21:42 INFO - Downloading docopt-0.6.1.tar.gz 17:21:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:21:42 INFO - Installing collected packages: blobuploader, requests, docopt 17:21:42 INFO - Running setup.py install for blobuploader 17:21:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:21:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:21:42 INFO - Running setup.py install for requests 17:21:43 INFO - Running setup.py install for docopt 17:21:43 INFO - Successfully installed blobuploader requests docopt 17:21:43 INFO - Cleaning up... 17:21:43 INFO - Return code: 0 17:21:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:21:43 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')]} 17:21:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:21:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:43 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')]} 17:21:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:21:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:43 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 0x10bf61b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf64768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed004b58d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd3fd30>, '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 0x10bc66db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd34be8>, '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.imdrghlOgd/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.YnZopf76ot/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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 17:21:43 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 17:21:43 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 17:21:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.imdrghlOgd/Render', 17:21:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:21:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:21:43 INFO - 'HOME': '/Users/cltbld', 17:21:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:21:43 INFO - 'LOGNAME': 'cltbld', 17:21:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:21:43 INFO - 'MOZ_NO_REMOTE': '1', 17:21:43 INFO - 'NO_EM_RESTART': '1', 17:21:43 INFO - 'PAGER': '/bin/cat', 17:21:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:21:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:21:43 INFO - 'PWD': '/builds/slave/test', 17:21:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:21:43 INFO - 'SHELL': '/bin/bash', 17:21:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YnZopf76ot/Listeners', 17:21:43 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 17:21:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:21:43 INFO - 'USER': 'cltbld', 17:21:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:21:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:21:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:21:43 INFO - 'XPC_FLAGS': '0x0', 17:21:43 INFO - 'XPC_SERVICE_NAME': '0', 17:21:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:21:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:21:43 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-OvQN7d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:21:43 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-23rHe_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:21:43 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-cOFtxX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:21:43 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-nBYujE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:21:43 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-yWfNXD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:21:44 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-TSfx91-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:21:44 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-c92bFQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:21:44 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-WMPohk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:21:44 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-7dNScY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:21:44 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-yGwM9z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:21:44 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-Rx18I3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:21:44 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-H4yzwS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:21:44 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-UVomCe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:21:44 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-nYVlIv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:21:45 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-kfAKej-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:21:45 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-UIor5w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:21:45 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-Ocpdn9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:21:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:21:45 INFO - Running setup.py install for manifestparser 17:21:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:21:45 INFO - Running setup.py install for mozcrash 17:21:45 INFO - Running setup.py install for mozdebug 17:21:45 INFO - Running setup.py install for mozdevice 17:21:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:21:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:21:45 INFO - Running setup.py install for mozfile 17:21:46 INFO - Running setup.py install for mozhttpd 17:21:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:21:46 INFO - Running setup.py install for mozinfo 17:21:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:21:46 INFO - Running setup.py install for mozInstall 17:21:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:21:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:21:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:21:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:21:46 INFO - Running setup.py install for mozleak 17:21:46 INFO - Running setup.py install for mozlog 17:21:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:21:46 INFO - Running setup.py install for moznetwork 17:21:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:21:46 INFO - Running setup.py install for mozprocess 17:21:47 INFO - Running setup.py install for mozprofile 17:21:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:21:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:21:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:21:47 INFO - Running setup.py install for mozrunner 17:21:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:21:47 INFO - Running setup.py install for mozscreenshot 17:21:47 INFO - Running setup.py install for moztest 17:21:47 INFO - Running setup.py install for mozversion 17:21:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:21:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:21:47 INFO - Cleaning up... 17:21:47 INFO - Return code: 0 17:21:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:21:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:21:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:21:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:21:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:47 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 0x10bf61b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf64768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed004b58d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd3fd30>, '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 0x10bc66db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd34be8>, '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.imdrghlOgd/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.YnZopf76ot/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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 17:21:47 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 17:21:47 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 17:21:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.imdrghlOgd/Render', 17:21:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:21:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:21:47 INFO - 'HOME': '/Users/cltbld', 17:21:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:21:47 INFO - 'LOGNAME': 'cltbld', 17:21:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:21:47 INFO - 'MOZ_NO_REMOTE': '1', 17:21:47 INFO - 'NO_EM_RESTART': '1', 17:21:47 INFO - 'PAGER': '/bin/cat', 17:21:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:21:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:21:47 INFO - 'PWD': '/builds/slave/test', 17:21:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:21:47 INFO - 'SHELL': '/bin/bash', 17:21:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YnZopf76ot/Listeners', 17:21:47 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 17:21:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:21:47 INFO - 'USER': 'cltbld', 17:21:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:21:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:21:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:21:47 INFO - 'XPC_FLAGS': '0x0', 17:21:47 INFO - 'XPC_SERVICE_NAME': '0', 17:21:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:21:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:21:48 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-_7XLzo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:21:48 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)) 17:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:21:48 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-7BeIvl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:21:48 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)) 17:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:21:48 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-fu_MwY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:21:48 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)) 17:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:21:48 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-N3tOqU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:21:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:21:48 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-kvU9o9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:21:48 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)) 17:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:21:48 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-G9qoTo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:21:48 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)) 17:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:21:48 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-kABU4O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:21:48 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)) 17:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:21:48 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-J9wXiW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:21:49 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)) 17:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:21:49 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-t6PPmL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:21:49 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)) 17:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:21:49 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-iWJ7wC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:21:49 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)) 17:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:21:49 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-u0erFm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:21:49 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)) 17:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:21:49 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-MyPwzQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:21:49 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)) 17:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:21:49 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-D1CoBY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:21:49 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)) 17:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:21:49 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-CtCjsr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:21:49 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)) 17:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:21:49 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-J6SJvy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:21:49 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)) 17:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:21:49 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-mmk3Yb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:21:49 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)) 17:21:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:21:49 INFO - Running setup.py (path:/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/pip-ECOcjz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:21:50 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)) 17:21:50 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)) 17:21:50 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)) 17:21:50 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)) 17:21:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:21:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:21:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:21:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:21:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:21:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:21:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:21:52 INFO - Downloading blessings-1.6.tar.gz 17:21:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:21:52 INFO - Installing collected packages: blessings 17:21:52 INFO - Running setup.py install for blessings 17:21:52 INFO - Successfully installed blessings 17:21:52 INFO - Cleaning up... 17:21:53 INFO - Return code: 0 17:21:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:21:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:21:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:21:53 INFO - Reading from file tmpfile_stdout 17:21:53 INFO - Current package versions: 17:21:53 INFO - blessings == 1.6 17:21:53 INFO - blobuploader == 1.2.4 17:21:53 INFO - docopt == 0.6.1 17:21:53 INFO - functools32 == 3.2.3-2 17:21:53 INFO - jsonschema == 2.5.1 17:21:53 INFO - manifestparser == 1.1 17:21:53 INFO - mozInstall == 1.12 17:21:53 INFO - mozcrash == 1.0 17:21:53 INFO - mozdebug == 0.1 17:21:53 INFO - mozdevice == 0.49 17:21:53 INFO - mozfile == 1.2 17:21:53 INFO - mozhttpd == 0.7 17:21:53 INFO - mozinfo == 0.9 17:21:53 INFO - mozleak == 0.1 17:21:53 INFO - mozlog == 3.4 17:21:53 INFO - moznetwork == 0.27 17:21:53 INFO - mozprocess == 0.25 17:21:53 INFO - mozprofile == 0.28 17:21:53 INFO - mozrunner == 6.13 17:21:53 INFO - mozscreenshot == 0.1 17:21:53 INFO - mozsystemmonitor == 0.3 17:21:53 INFO - moztest == 0.8 17:21:53 INFO - mozversion == 1.4 17:21:53 INFO - psutil == 3.1.1 17:21:53 INFO - requests == 1.2.3 17:21:53 INFO - wsgiref == 0.1.2 17:21:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:21:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:21:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:21:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:21:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:21:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:53 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 0x10bf61b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf64768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed004b58d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd3fd30>, '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 0x10bc66db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd34be8>, '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.imdrghlOgd/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.YnZopf76ot/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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 17:21:53 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 17:21:53 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 17:21:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.imdrghlOgd/Render', 17:21:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:21:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:21:53 INFO - 'HOME': '/Users/cltbld', 17:21:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:21:53 INFO - 'LOGNAME': 'cltbld', 17:21:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:21:53 INFO - 'MOZ_NO_REMOTE': '1', 17:21:53 INFO - 'NO_EM_RESTART': '1', 17:21:53 INFO - 'PAGER': '/bin/cat', 17:21:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:21:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:21:53 INFO - 'PWD': '/builds/slave/test', 17:21:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:21:53 INFO - 'SHELL': '/bin/bash', 17:21:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YnZopf76ot/Listeners', 17:21:53 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 17:21:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:21:53 INFO - 'USER': 'cltbld', 17:21:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:21:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:21:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:21:53 INFO - 'XPC_FLAGS': '0x0', 17:21:53 INFO - 'XPC_SERVICE_NAME': '0', 17:21:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:21:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:21:53 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)) 17:21:53 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)) 17:21:53 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)) 17:21:53 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)) 17:21:53 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)) 17:21:53 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)) 17:21:53 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)) 17:21:53 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)) 17:21:53 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)) 17:21:53 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)) 17:21:53 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)) 17:21:53 INFO - Cleaning up... 17:21:53 INFO - Return code: 0 17:21:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:21:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:21:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:21:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:21:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:21:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:53 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 0x10bf61b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf64768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed004b58d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd3fd30>, '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 0x10bc66db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd34be8>, '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.imdrghlOgd/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.YnZopf76ot/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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 17:21:53 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 17:21:53 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 17:21:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.imdrghlOgd/Render', 17:21:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:21:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:21:53 INFO - 'HOME': '/Users/cltbld', 17:21:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:21:53 INFO - 'LOGNAME': 'cltbld', 17:21:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:21:53 INFO - 'MOZ_NO_REMOTE': '1', 17:21:53 INFO - 'NO_EM_RESTART': '1', 17:21:53 INFO - 'PAGER': '/bin/cat', 17:21:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:21:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:21:53 INFO - 'PWD': '/builds/slave/test', 17:21:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:21:53 INFO - 'SHELL': '/bin/bash', 17:21:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YnZopf76ot/Listeners', 17:21:53 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 17:21:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:21:53 INFO - 'USER': 'cltbld', 17:21:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:21:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:21:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:21:53 INFO - 'XPC_FLAGS': '0x0', 17:21:53 INFO - 'XPC_SERVICE_NAME': '0', 17:21:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:21:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:21:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:21:53 INFO - Cleaning up... 17:21:53 INFO - Return code: 0 17:21:53 INFO - Running post-action listener: _resource_record_post_action 17:21:53 INFO - Running post-action listener: _start_resource_monitoring 17:21:53 INFO - Starting resource monitoring. 17:21:53 INFO - [mozharness: 2017-03-22 00:21:53.897339Z] Finished create-virtualenv step (success) 17:21:53 INFO - [mozharness: 2017-03-22 00:21:53.898297Z] Running install step. 17:21:53 INFO - Running pre-action listener: _resource_record_pre_action 17:21:53 INFO - Running main action method: install 17:21:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:21:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:21:54 INFO - Reading from file tmpfile_stdout 17:21:54 INFO - Detecting whether we're running mozinstall >=1.0... 17:21:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:21:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:21:54 INFO - Reading from file tmpfile_stdout 17:21:54 INFO - Output received: 17:21:54 INFO - Usage: mozinstall [options] installer 17:21:54 INFO - Options: 17:21:54 INFO - -h, --help show this help message and exit 17:21:54 INFO - -d DEST, --destination=DEST 17:21:54 INFO - Directory to install application into. [default: 17:21:54 INFO - "/builds/slave/test"] 17:21:54 INFO - --app=APP Application being installed. [default: firefox] 17:21:54 INFO - mkdir: /builds/slave/test/build/application 17:21:54 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'] 17:21:54 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 17:22:14 INFO - Reading from file tmpfile_stdout 17:22:14 INFO - Output received: 17:22:14 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:22:14 INFO - Running post-action listener: _resource_record_post_action 17:22:14 INFO - [mozharness: 2017-03-22 00:22:14.503668Z] Finished install step (success) 17:22:14 INFO - [mozharness: 2017-03-22 00:22:14.503819Z] Running run-tests step. 17:22:14 INFO - Running pre-action listener: _resource_record_pre_action 17:22:14 INFO - Running main action method: run_tests 17:22:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:22:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:22:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:22:14 INFO - 2017-03-21 17:22:14.518 screenresolution[1628:8967] starting screenresolution argv=screenresolution get 17:22:14 INFO - 2017-03-21 17:22:14.520 screenresolution[1628:8967] Display 0: 1600x1200x32@60 17:22:14 INFO - 2017-03-21 17:22:14.526 screenresolution[1629:8970] starting screenresolution argv=screenresolution list 17:22:14 INFO - Available Modes on Display 0 17:22:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:22:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:22:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:22:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:22:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:22:14 INFO - Intel Iris: 17:22:14 INFO - Chipset Model: Intel Iris 17:22:14 INFO - Type: GPU 17:22:14 INFO - Bus: Built-In 17:22:14 INFO - VRAM (Dynamic, Max): 1536 MB 17:22:14 INFO - Vendor: Intel (0x8086) 17:22:14 INFO - Device ID: 0x0a2e 17:22:14 INFO - Revision ID: 0x0009 17:22:14 INFO - Displays: 17:22:14 INFO - Display: 17:22:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:22:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:22:14 INFO - Display Serial Number: 1600x1200 60 17:22:14 INFO - Main Display: Yes 17:22:14 INFO - Mirror: Off 17:22:14 INFO - Online: Yes 17:22:14 INFO - Rotation: Supported 17:22:14 INFO - Return code: 0 17:22:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:22:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:22:14 INFO - Python 2.7.3 17:22:14 INFO - Return code: 0 17:22:14 INFO - grabbing minidump binary from tooltool 17:22: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')]} 17:22:14 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 0x10bd3fd30>, '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 0x10bc66db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bd34be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:22:14 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 17:22:14 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 17:22:14 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 17:22:14 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:22:14 INFO - Return code: 0 17:22:14 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:22:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:22:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:22:14 INFO - ENV: RUST_BACKTRACE is now 1 17:22:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:22:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:22:14 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/bzwaR3AHTROGsrH592UvYA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0188', '--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 17:22:14 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/bzwaR3AHTROGsrH592UvYA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0188 --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 17:22:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.imdrghlOgd/Render', 17:22:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:22:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:22:14 INFO - 'HOME': '/Users/cltbld', 17:22:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:22:14 INFO - 'LOGNAME': 'cltbld', 17:22:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:22:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:22:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:14 INFO - 'MOZ_NO_REMOTE': '1', 17:22:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:22:14 INFO - 'NO_EM_RESTART': '1', 17:22:14 INFO - 'PAGER': '/bin/cat', 17:22:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:22:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:14 INFO - 'PWD': '/builds/slave/test', 17:22:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:22:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:22:14 INFO - 'RUST_BACKTRACE': '1', 17:22:14 INFO - 'SHELL': '/bin/bash', 17:22:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YnZopf76ot/Listeners', 17:22:14 INFO - 'TMPDIR': '/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/', 17:22:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:22:14 INFO - 'USER': 'cltbld', 17:22:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:22:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:22:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:14 INFO - 'XPC_FLAGS': '0x0', 17:22:14 INFO - 'XPC_SERVICE_NAME': '0', 17:22:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:22:14 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/bzwaR3AHTROGsrH592UvYA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0188', '--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 17:22:15 INFO - mozversion application_buildid: 20170321160934 17:22:15 INFO - mozversion application_changeset: 8744e9f8eb99f1290aae81985812d57364f18708 17:22:15 INFO - mozversion application_display_name: Nightly 17:22:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:22:15 INFO - mozversion application_name: Firefox 17:22:15 INFO - mozversion application_remotingname: firefox 17:22:15 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:22:15 INFO - mozversion application_vendor: Mozilla 17:22:15 INFO - mozversion application_version: 55.0a1 17:22:15 INFO - mozversion platform_buildid: 20170321160934 17:22:15 INFO - mozversion platform_changeset: 8744e9f8eb99f1290aae81985812d57364f18708 17:22:15 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:22:15 INFO - mozversion platform_version: 55.0a1 17:22:15 INFO - using testdate: 1490142135 17:22:15 INFO - actual date: 1490142135 17:22:15 INFO - starting webserver on 'localhost:49242' 17:22:15 INFO - SUITE-START | Running 2 tests 17:22:15 INFO - TEST-START | dromaeo_css 17:22:15 INFO - operating with platform_type : mac_ 17:22:15 INFO - Initialising browser for dromaeo_css test... 17:22:15 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/tmpF4bgoI/profile http://localhost:49242/getInfo.html) 17:22:18 INFO - PID 1639 | 2017-03-21 17:22:18.157 plugin-container[1641:9156] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e3f, name = 'com.apple.tsm.portname' 17:22:18 INFO - PID 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:22:18 INFO - PID 1639 | 2017-03-21 17:22:18.160 plugin-container[1641:9156] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 17:22:18 INFO - PID 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:22:18 INFO - PID 1639 | 2017-03-21 17:22:18.161 plugin-container[1641:9156] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:22:18 INFO - PID 1639 | __metrics Screen width/height:1600/1200 17:22:18 INFO - PID 1639 | colorDepth:24 17:22:18 INFO - PID 1639 | Browser inner width/height: 1024/689 17:22:18 INFO - PID 1639 | __metrics 17:22:18 ERROR - PID 1639 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3350: TypeError: this.tabs is undefined 17:22:19 INFO - TEST-INFO | 1639: exit 0 17:22:19 INFO - Browser initialized. 17:22:19 INFO - Running cycle 1/1 for dromaeo_css test... 17:22:19 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/tmpF4bgoI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:22:21 INFO - PID 1643 | 2017-03-21 17:22:21.555 plugin-container[1644:9289] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 17:22:21 INFO - PID 1643 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:22:21 INFO - PID 1643 | 2017-03-21 17:22:21.556 plugin-container[1644:9289] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 17:22:21 INFO - PID 1643 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:22:21 INFO - PID 1643 | 2017-03-21 17:22:21.556 plugin-container[1644:9289] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:22:31 INFO - PID 1643 | RSS: Main: 228139008 17:22:31 INFO - PID 1643 | 17:25:36 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49242/tests/dromaeo/cssquery-ext.html) 17:25:38 INFO - PID 1643 | RSS: Main: 251023360 17:25:38 INFO - PID 1643 | 17:27:19 INFO - PID 1643 | ************************* 17:27:19 INFO - PID 1643 | A coding exception was thrown and uncaught in a Task. 17:27:19 INFO - PID 1643 | 17:27:19 ERROR - PID 1643 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:27:19 INFO - PID 1643 | Full stack: 17:27:19 INFO - PID 1643 | ************************* 17:28:40 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-ext.html (next: http://localhost:49242/tests/dromaeo/cssquery-jquery.html) 17:28:41 INFO - PID 1643 | RSS: Main: 258777088 17:28:41 INFO - PID 1643 | 17:31:42 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49242/tests/dromaeo/cssquery-mootools.html) 17:31:43 INFO - PID 1643 | RSS: Main: 269918208 17:31:43 INFO - PID 1643 | 17:34:45 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49242/tests/dromaeo/cssquery-prototype.html) 17:34:46 INFO - PID 1643 | RSS: Main: 263729152 17:34:46 INFO - PID 1643 | 17:37:48 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49242/tests/dromaeo/cssquery-yui.html) 17:37:49 INFO - PID 1643 | RSS: Main: 273448960 17:37:49 INFO - PID 1643 | 17:40:52 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-yui.html (next: http://localhost:49242/tests/dromaeo/cssquery-dojo.html) 17:40:52 INFO - PID 1643 | RSS: Main: 267571200 17:40:52 INFO - PID 1643 | 17:40:52 INFO - PID 1643 | __start_tp_report 17:40:52 INFO - PID 1643 | _x_x_mozilla_page_load 17:40:52 INFO - PID 1643 | _x_x_mozilla_page_load_details 17:40:52 INFO - PID 1643 | |i|pagename|runs| 17:40:52 INFO - PID 1643 | |0;dojo.html;3518.54258946337;3522.436410174371;3537.1687653401464;3570.1788588624618;3579.0694419450933;4548.567886050824;6091.055886337614;6176.845578860531;6198.132261483384;6227.43953044226;5018.899622007558;6103.60326578772;6118.3450802373245;6199.752009919609;6219.689015549216;5476;5509.146082357221;5544.500994910457;5595.160725891128;5648.661080335172;4611.7232966021975;5495.42797181833;5565.777368905239;5602.075657516505;5644.096944488862;5447.319085114361;5500.4499550045075;5532.3914369419335;5563.332400111972;5576.107822748381;5488.725563721838;5511.807086751945;5540.141278101901;5543.25166102575;5555.916661250085;5421.701806400646;5449.591280653967;5456.372517160537;5461.754221060062;5467.9453205467835;5969.432903874168;6074.119252708377;6103.87792244157;6108.480779133779;6166.013437849922;6385.233771947396;6412.61524308543;6426.1003459515705;6517.641529715864;6572.638504882229;6694.330566943316;6705.5976641401185;6713.765018224339;6717.832054198684;6727.865442691119;6199.16311297969;6261.78083767066;6278.4035516625845;6280.937190628127;6295.685215739195;6116.518381401602;6578;6724.966375168093;6844.931550684529;6851.828704282433;6298.685065746694;6358.205224346957;6414.486841052704;6421.133147025185;6515.250746164157;5814.912776308359;6474.4496717778575;6602.570832895846;6638.834029149213;6658.933410665832;6563.737450502022;6568.901466478007;6570.342965703487;6574.638394888231;6605.636689982001;6349.904751428732;6432.844996925988;6471.644059576768;6600.5049621278595;6623.536352455379;5202;5252.133397989365;5275;5297.417284098746;5329.987302412529;4689.343491911135;4689.906201875943;4711.269753188261;4724.267738500538;4744.881377965578;6225.159603453566;6282.685865706696;6305.527085468608;6307.684615769285;6321.051842223611;6406.615603063831;6512.218533775977;6586.176727909012;6590.176227971504;6648.700808463631;6209.441150296495;6241.500679945593;6259.374062593704;6268.49852011838;6271.717772700239;4934.284528743384;5851.385604511465;5872.941270587325;5873.853153671107;5881.676507792027;6639.568428052161;6777.864442711019;6788.321167883172;6800.897986530107;6811.89782153278;6650.235222949423;6651.767188148391;6670.933290667225;6715.56348837324;6739.224989126314;6837.418819400406;6840.589564626139;6849.1096157499205;6860.073890024983;6891.483138764513;6347.428731414195;6424.903626445701;6483.708233129426;6533.118029066205;6551.574147680385;6565.638889861103;6659.667016649245;6678.365555272241;6679;6709.731610735711;6281.59169653971;6436.227652681521;6449.12936753551;6450.774222902176;6480.287168411565;5740.68426236561;6211.819754246679;6242.843928901813;6393.328700486382;6399.392057754506;6206.224221972254;6340.239171299474;6353.332900045429;6391.10524526576;6430.324815894263;6488.870222595428;6492.610443373413;6503;6504.707288171949;6510.544261901621;6199.659018754011;6221.844453888508;6296.496280297473;6340.524460665561;6343.365663433619 17:40:52 INFO - PID 1643 | |1;ext.html;737.2958824322773;810.116972499975;828.2338836576167;1256.2336974445593;1273.8853503184712;37825.24349513008;38859.02852428691;38993;39007.41488877669;39040.21919561607;38768;38814.22371552567;39015;39065.41401878967;39130;7908;8047.597620119;8368.372372072088;8622.180892815173;8642.351823613255;6855.862882742342;8679.349048821332;8682.652693892269;8697.304215662763;8713;8648.178423049832;8735.694250701226;8742.038375778659;8745.125487451267;8746.825063498727;8681.826363472726;8713.302935765123;8717.694880679146;8725.650973961066;8743.431676940978;8568.914310856937;8572.357073219533;8578.613962371646;8626.137386261387;8628.784280392978;38643.420348694795;38941.8317450477;38958.80520597407;38961.41557876634;38985;3002.549617557362;3024.2892920163745;3036.316828713544;3042.680518545543;3047.420990011891;28383.716162838315;28526.71473285261;28598.285042873886;28605.57091643627;29532.704672953427;2777.4167424840807;2778;2785.749282564579;2802.397484540813;2827.3073097091346;297822;315086;318131;320191;321275.78724212694;46123.61629151131;51126.744366278675;51167.48832511702;51221;51464.48535514672;49773.75113124411;53370.19944700832;53391.73304133455;53627.46372536303;53751;14279.500217492337;14696.338664760111;14714.632134196516;14716.632084197981;14721.779173312409;11924.76150477003;11959.162858599988;11968;11972.16194866351;12013.27920324766;11975.221610595283;12488.000959923183;12925.870741292654;13598.796018059737;14028;5417.510184699239;5719.685417302088;5973.820785376446;6044.274687037584;6100.786472473442;875.3522393428944;987.456898705709;988.1748739802346;1010.751721623794;1014.5181039006413;22000.88999554992;22178.556428871656;22763.317100487013;23881.381046538547;24483.632745508832;913.8355096082769;1069.1767339148812;1116.1963386361806;1119.6081371519904;1120.7030137013699;11374.31754094757;11824.645260642195;12503.87496125027;12513.3743312834;12540.122191446693;456341;458820;459308;460478.39521605027;461068;45755.08489830251;54965.17552236719;55491;56674.7166264166;57288.85422291614;1294.4110429754628;1415.8796502297214;1417.2134465371817;1440.2510694439043;1448.2107251547932;23035.308940731804;24902.875485622455;28809.27976800513;28899;29131.417371652024;32896;37193.628063719014;37420.877373678835;37436;37607.62392376041;385295;386513;389259;390606;390861;32813.67186328106;33295.83464578825;33476.83261583676;33497.48276431037;33527.83236083804;41599.168016640106;41840;42263.57736422597;43341;43468.91327716832;34841.12897177591;35015.299694005465;35169.29661406706;35733.57065717446;36172.638273616925;28439.573406399333;29159.562606560496;34841.825790870884;34859.65140348564;35721.46417803787;33568.66431335655;35769.46345804763;35982.64017359898;36281.63718362783;36514.45228321524;27406.228147178066;31266.144736319526;31425.685743142276;31743.523847142773;31848.681513184572;21468.57062858703;24340.878295608407;24389.02443902224;24428.145014924394;24552.263432097065 17:40:52 INFO - PID 1643 | |2;jquery.html;422.69988308301106;423.5922007450064;433.61408346571545;448.4192970103715;448.82047181127547;18860.905695471538;20745.06647200876;21303.04136313866;21526.677099843513;21533.46166345842;18452;20736;22731.431714207152;23526.823658817077;23640.76359236407;6169.814905552829;6354.332795056522;6393.968030159843;6397.040443933401;6397.744090236408;6008.575112186056;6285.842853928642;6378.234611846562;6392.424681778639;6482.967585162068;5334.546563542103;6080.087986801971;6329.113924050636;6338.080978258173;6344.3655634436645;6223.097650840626;6331.2085989251345;6345.111684364193;6348.777792777254;6364.681765911686;5367.382750983647;5537;5577.107662773937;5580.720963951827;5618.297712785902;26745.79643916009;26897.86551067232;27222.319442014108;27259.318517037034;27315.907363705428;2026.230032587622;2047.6109539187655;2074.8132668059948;2083.395815213586;2143.946401339979;15809.683806323808;16149.354025838953;16302.918485407616;16349.59126021847;16666.166691665367;1680.1011458869446;1697.3634886917405;1713.2632967823831;1715.5968347438343;1718.535995281267;124701;138949;141768;143389.8491522628;144198;10419;12041.397930103634;12514.249145051326;12523;12704.364781760874;15768.132752698712;15777.447789327318;15784.92107539455;15787.131707755954;15829.287682054104;8442.62008209632;8618.310535157172;8650.178233067849;8711.08533603975;8741.256993155526;8158.673653053811;8165.95917020423;8169.346452283803;8328.583570821434;8330.04244002659;6483.870322593616;6725.495587830932;7806.063272407234;7830.647620857075;7848.175941526171;1829.5883426228993;2107.766956330564;2130.5099827039867;2131.1155870313955;2148.172953412916;946;968.9515524223901;972.1590823937244;972.2853702528636;1010.6109147978082;16853.747193792104;20889.582208355747;21058.68411973791;21083.15667373288;21210.681839772416;895.6909866096187;923.7044145873256;965.1217392173229;1011.1506334678905;1020.5203554329453;10009.449480278654;10358.067773900235;10399;10435.478226088817;10573.735656608493;680936;701177.9882201112;701962.8421360083;707177;715995;118669.21996169892;135110;137487.6251237495;141070;170276.99999999753;1095.45774841454;1182.4442512019336;1204.476052916984;1237.0845574274972;1244.6266120164096;18290.085495725427;20386.898065509577;21298.36104916855;21511.892440537697;21632.24287149942;55977.72011139918;61960.69019654873;62512.687436562526;63815.36184638094;63998.36001639924;88009;89578;89584.10415895758;90010;90548;8383.874241886499;8396.580170991549;8600.22597966186;8801.07588703177;8891.19979201875;13043.543475978295;13374.331283435984;13558.79661805054;13591.388387522387;13662.795058074336;11371.943140284246;11574.37944801263;11737.88262117402;11854.585089521825;11864;10356.689299321033;11156.163287753614;11275.605353812578;11584.768304633692;11666.824997624874;8856.955715221382;9639.614415423304;11344.716382090184;11725.003374712904;12035.157538972539;7447.255274472726;7479.738209162653;8630.352723545884;8807.339449541181;8996.820063598821;9602.759931001781;11880.524779008743;12059.457324420247;12184;12221.572244971383 17:40:52 INFO - PID 1643 | |3;mootools.html;1365.8429280632727;1432.4556668465982;1436.1311406599007;1438.8561093930325;1455.7597996330603;10278.948605256972;10570.894291057088;10700.357978521295;10710.785784284319;10816.567337306498;8394.664213431455;9032.819343613124;10459.73850653734;10567.207459440535;10642.308249963748;2380.250221180327;2417.8791060446997;2420.2376251480814;2420.721617014048;2429.757024297574;2352.9882350588223;2403.110848985869;2415.4444477770126;2417.5527527407485;2418.6855708757835;2054.5069183396026;2382.118616112032;2405.867677277749;2424.7696468835434;2427.587310157269;2363.8818059096975;2385.117506522589;2396.1254142238045;2406.03758496601;2406.5547873643345;2305.4697419593585;2364.775346342112;2402.8438151520095;2418.5404773093055;2420.3707036170545;10508.84236736442;10585.311954722918;10599.258051936367;10599.788004239872;10624.575016999312;6102.572819902609;6263;6308.116863639094;6313;6313.494920406402;3925.450436938831;3949.861754838567;3967.4247234151176;4005.198960207941;4040.5555388907196;1172.4313707851686;1280.737448822989;1344.5529136970717;1575.8109026916843;1577.0823975644964;15071.246437678072;15078.793696504254;15087;15208.08751474904;15224.314905829264;4533.818647254139;5122.974385128051;5277.366715994105;5334.306540149756;5396.622236443412;11228.270162439416;11281.435928203557;11332.980031797179;11359;11365;6137.5703700741415;6216.409441103088;6232.750689972441;6252.3122456529745;6262.718177682015;5562.054450743383;5675.489205971482;5808.157817116579;5838.328592211865;5842.707864606838;3596.514470546495;4162.666986641061;4227.365895115696;4265.3815196796295;4329.393884856123;1075.596651255779;1105.8894110589038;1230.446299165379;1259.8803113704184;1273.961781146567;741.4365082537311;747.986478321866;770.7995921060565;771.5872008475438;808.9191080891982;5532.225488431623;6325.778597749057;6715.9590263509235;6717.563358381787;6727.865442691119;871.172386233081;898.7034278688018;911.3256190419042;913.6756451459636;914.9021174590519;4079.8776036718946;4096.160287141129;4138.089620283533;4190.497140343117;4204.2432362175105;13461.326933653474;13688.863111368759;13911;13923.651908702364;13931.860681393056;12308.753824923451;12719.618411447671;13584.204274944395;13877.653058673613;13877.653058673613;8221.958890205511;10053.69838904834;10264;10336.224783141295;10343.189941760162;5019.472955339783;6184.81445556634;6273.52948528853;6379.298277189413;6441.742330306735;12085.697857553632;12360.134790564574;12474.251544907334;12494.43775030144;12664.176828506117;10625.840612390975;12211.755764884474;12465.376731163587;12807.487700491876;13056.738865222833;7673.61631918413;8868;9076.364654474124;9076.773080673036;9089.681861134828;8442.366822488215;10061.798764024825;10108.747281317732;10197.490125493547;10231.795364092824;8800.735977920673;8933.28533717288;8987.820243595223;9006.954965225132;9073.45559266446;7377.77866664001;8849.646014159362;8866.246369058445;8876.112388761072;8978.86531702038;6577.243616983917;7540.3213710766295;7657.655405506877;7664;7684.001079859582;5641.26663533738;5664.207011018543;5739.167820665896;5753.741081651419;5851.297844258716;5682.516986056232;5711.171880077449;5890.381509941394;5961.791337303173;6093.329733729198 17:40:52 INFO - PID 1643 | |4;prototype.html;354.7889006041406;383.9289731399691;399.38694104549523;399.93001224785667;403.2338556742188;4491.25894227452;6006.7897623583185;6107.0532868376595;6213.130161777355;6257.593256438334;5783.033768518702;5930.940690593093;6000.389830423758;6008.128821320905;6012.947734146529;4709.481956984729;4727.621790256771;4740.123077230706;4749.453812811519;4761.357216775743;4585.610223131038;4597.264437689971;4685.5548722871445;4726.432828060638;4771.40158047053;4079.551249362568;4690.976545117287;4706.811727530895;4714.3164241185;4725.196716558176;3846.7499612525376;4697.459792123898;4716.009637976029;4751.643626727975;4753.928691069636;3749.4750734897134;4070.206309769596;4152.854650087233;4173.768738222232;4189.560096189917;4806.8798280043275;5361.517463428271;5821.8253452396075;5866.911996320058;5897.734601942923;4539.500654927955;5446.809361672323;5461.0716178249795;5471.917921231145;5497.890042199134;6195.7521699131985;6410.1987251593555;6481.48148148147;6522.608643481406;6550;3887.5723670396233;4272.444582204324;4627.5603817637275;4649.814007439699;4663.580277775017;5419.783208671648;6465.900796864545;6572.0141978703095;6759.898601520932;6823.249442561314;4780;4790.473047964721;4797.808087676523;4811.291991343092;4829;4760.95239047612;4888.902221955612;4896.290037944478;4903.730294833818;4920.901581968341;5025.522575355335;5305.867353316198;5327;5357.249985002103;5549.890021995617;5797.188393624896;6074.11702372266;6550.901736473957;6575.473962083021;6576.671166441659;1473.8010368600317;1516.9317380717894;1537.49325660853;1538.5999640093432;1550.2095080182407;1010.7068950004564;1011.5195282241024;1019.3476175247847;1022.974425639365;1025.9435731034864;5370;6061.727222275008;6072.937235983685;6109.480694140959;6165.969170154211;5428.701421421781;6542.988426665337;6679.931211006216;6706.396424321834;6756.7972960810275;4765.332853400527;6015.54883383748;6087.96956015226;6098.54260930432;6108.083787431832;3268.7711860170034;3495.807730574843;3503.2515208726927;3532.1875968527384;3543.4153364695053;5862.941370586324;5912.4627596824275;6136.834001539783;6486.772962946368;6644.940068578756;5226.686398816008;5757.625754325955;6342.270638876496;6645.833854153685;6907.827304317332;6341.048842673636;6396.976483762575;6614.371634694792;6628.017392173541;6712.791697494498;5887.735051922759;6385.074164246065;6559.147310849559;6747.190337159573;6756.459483241427;5995.820125396245;6404.583702059351;6581.572197807127;6604.537682362381;6650.168728908887;6501.967490162708;6870.62211578368;6878.449724022166;6944.166699995831;6952.44380449573;4082.530508991504;4358;4383.868483945486;4408.867733967986;4434.871261794421;5902.704864756831;6122.387761223842;6433.678316084271;6544.738210471528;6637.701303441453;6435.03474478832;6460.773872914613;6469.644169570531;6478.2550006749825;6524.347565243438;5072.797088116582;6012.609180403259;6186.876262474635;6375.776847810304;6470.35296470368;5338.706371149624;5586.525205298749;6331;6366.522510811615;6416.550841441054;5599.796043850592;5776.971115144397;6516.6415847128865;6538.738450462119;6545.8690826184165;6203;6262.624242545462;6275.968620157053;6282.6440084968135;6297.244330680348 17:40:52 INFO - PID 1643 | |5;yui.html;651.2868409092044;709.3183599369053;728.8469421421502;730.200430528571;746.5259560179285;14876.033057851231;15841.683166336696;15973;15974.121423321712;16047.358105675774;12596.93701531491;13180.209187448736;14824.851751482482;14927.77608335873;15260.542183734506;924.3529529329479;948.0661548374845;949.7862980829327;950.5579905344014;952.6618050592009;914.2183433164648;940.6613619097119;941.472775245861;950.3442624589046;953.4708236928502;850.7830503221701;881.5636260051284;1007.6775431861807;1009.6920439266021;1017.2675673515057;982.4891056650501;1003.1473247739436;1007.3200589602026;1007.4459047523833;1010.8534262531965;726.150404027284;743.8958545803591;751.1399447632431;751.5640928261649;753.8266198774313;15935.203239837962;16347.673046539121;16493.917530412393;16604.08677522736;16878.156092195342;12507.437165327583;14519.491817786327;14577.344019519147;14696.130402843182;14739.778903316459;11886.40567971598;11940.164188506807;11956.820647690292;12148.514059437612;12492.625221243377;2794.8820471811237;3015.366772977677;3074.169974107001;3115.2679120406688;3140.1678555182893;112500;114908;116387.41806290999;118089;120089.39955300256;11268.661940141808;11285.774284514428;11346.94326528362;11393.544258229578;11833.940830295965;21861.67207491857;24434;24778.380540486633;25183.496330073296;25222.369440764127;6748.831279218059;7580.734674286374;7713.460057796013;7730.072391313079;7844;3637.3452778499595;3727.6272372762505;3747.6065013173225;3750.1562148516364;3780.9621903781162;4047.0799014606596;4177.227212965611;4201.516825565038;4203.810828512725;4207.179599978036;780.5667854340782;781.4881252779438;787.8424315136996;788.8580055590049;805.2229598437536;466.6266986410858;475.28895974491553;485.09045539613226;513.8407093800934;521.0750917122062;9688.32181747271;9757.951210244046;9994.500274986221;10019.048190421898;10249.641262555775;546.3007350591249;556.2018503447566;572.9570282228849;574.3940143149018;579.5305802300066;4021.4718407005153;4531.614812740954;4619.976900115478;4626.444826620827;4681.695689780154;58181;69282.65358673275;98662.50668746754;99902;100790.99209007816;63584.68207658932;71370.2862971374;71436.64281678558;77983;78810;70627.64686176639;71137.57724845473;72098.99999999895;72710.90933636;72807.45173918888;8677.566121694017;10241.129503991946;10652;10817.837732433862;10848.457577120955;29337.559936601396;33357.33285334328;34654.653453465144;36713.265734685694;39148.217035658556;56126.719366402904;58964.70517647384;61118.694406527684;61543.38456615376;66289.66855165693;13553.839109748524;13953.953453491233;14120.435182592992;14220.502282420066;14311.57065288043;14205.218712970473;14707.779383309473;14818.333175006936;14983.625409364853;15524.84475155234;13265.933670331586;13531.932340338235;13782.586522404345;13827.79258311106;14098.436062557383;13546.458141674617;13854.30728463593;13992.650183745487;14028.719425611635;14270.500532481314;13318.667033324244;13419.396127174105;13513.662158446117;13565.932170339085;14286.28568571588;11211.831822522505;11233.71915702114;11320.490577924178;11362.886371136183;11363.886361136614;7702.961485192538;9971.850422243528;10904.61833835812;11279.32324060559;11607.36159511235 17:40:52 INFO - PID 1643 | __end_tp_report 17:40:52 INFO - PID 1643 | __start_cc_report 17:40:52 INFO - PID 1643 | _x_x_mozilla_cycle_collect,420 17:40:52 INFO - PID 1643 | __end_cc_report 17:40:52 INFO - PID 1643 | __startTimestamp1490143252503__endTimestamp 17:40:52 INFO - PID 1643 | 17:40:52 INFO - PID 1643 | ------- Summary: start ------- 17:40:52 INFO - PID 1643 | Number of tests: 6 17:40:52 INFO - PID 1643 | 17:40:52 INFO - PID 1643 | [#0] dojo.html Cycles:165 Average:6083.39 Median:6298.69 stddev:705.79 (11.2%) stddev-sans-first:678.66 17:40:52 INFO - PID 1643 | Values: 3518.5 3522.4 3537.2 3570.2 3579.1 4548.6 6091.1 6176.8 6198.1 6227.4 5018.9 6103.6 6118.3 6199.8 6219.7 5476.0 5509.1 5544.5 5595.2 5648.7 4611.7 5495.4 5565.8 5602.1 5644.1 5447.3 5500.4 5532.4 5563.3 5576.1 5488.7 5511.8 5540.1 5543.3 5555.9 5421.7 5449.6 5456.4 5461.8 5467.9 5969.4 6074.1 6103.9 6108.5 6166.0 6385.2 6412.6 6426.1 6517.6 6572.6 6694.3 6705.6 6713.8 6717.8 6727.9 6199.2 6261.8 6278.4 6280.9 6295.7 6116.5 6578.0 6725.0 6844.9 6851.8 6298.7 6358.2 6414.5 6421.1 6515.3 5814.9 6474.4 6602.6 6638.8 6658.9 6563.7 6568.9 6570.3 6574.6 6605.6 6349.9 6432.8 6471.6 6600.5 6623.5 5202.0 5252.1 5275.0 5297.4 5330.0 4689.3 4689.9 4711.3 4724.3 4744.9 6225.2 6282.7 6305.5 6307.7 6321.1 6406.6 6512.2 6586.2 6590.2 6648.7 6209.4 6241.5 6259.4 6268.5 6271.7 4934.3 5851.4 5872.9 5873.9 5881.7 6639.6 6777.9 6788.3 6800.9 6811.9 6650.2 6651.8 6670.9 6715.6 6739.2 6837.4 6840.6 6849.1 6860.1 6891.5 6347.4 6424.9 6483.7 6533.1 6551.6 6565.6 6659.7 6678.4 6679.0 6709.7 6281.6 6436.2 6449.1 6450.8 6480.3 5740.7 6211.8 6242.8 6393.3 6399.4 6206.2 6340.2 6353.3 6391.1 6430.3 6488.9 6492.6 6503.0 6504.7 6510.5 6199.7 6221.8 6296.5 6340.5 6343.4 17:40:52 INFO - PID 1643 | 17:40:52 INFO - PID 1643 | [#1] ext.html Cycles:180 Average:52656.97 Median:36077.64 stddev:103879.59 (287.9%) stddev-sans-first:104097.86 17:40:52 INFO - PID 1643 | Values: 737.3 810.1 828.2 1256.2 1273.9 37825.2 38859.0 38993.0 39007.4 39040.2 38768.0 38814.2 39015.0 39065.4 39130.0 7908.0 8047.6 8368.4 8622.2 8642.4 6855.9 8679.3 8682.7 8697.3 8713.0 8648.2 8735.7 8742.0 8745.1 8746.8 8681.8 8713.3 8717.7 8725.7 8743.4 8568.9 8572.4 8578.6 8626.1 8628.8 38643.4 38941.8 38958.8 38961.4 38985.0 3002.5 3024.3 3036.3 3042.7 3047.4 28383.7 28526.7 28598.3 28605.6 29532.7 2777.4 2778.0 2785.7 2802.4 2827.3 297822.0 315086.0 318131.0 320191.0 321275.8 46123.6 51126.7 51167.5 51221.0 51464.5 49773.8 53370.2 53391.7 53627.5 53751.0 14279.5 14696.3 14714.6 14716.6 14721.8 11924.8 11959.2 11968.0 11972.2 12013.3 11975.2 12488.0 12925.9 13598.8 14028.0 5417.5 5719.7 5973.8 6044.3 6100.8 875.4 987.5 988.2 1010.8 1014.5 22000.9 22178.6 22763.3 23881.4 24483.6 913.8 1069.2 1116.2 1119.6 1120.7 11374.3 11824.6 12503.9 12513.4 12540.1 456341.0 458820.0 459308.0 460478.4 461068.0 45755.1 54965.2 55491.0 56674.7 57288.9 1294.4 1415.9 1417.2 1440.3 1448.2 23035.3 24902.9 28809.3 28899.0 29131.4 32896.0 37193.6 37420.9 37436.0 37607.6 385295.0 386513.0 389259.0 390606.0 390861.0 32813.7 33295.8 33476.8 33497.5 33527.8 41599.2 41840.0 42263.6 43341.0 43468.9 34841.1 35015.3 35169.3 35733.6 36172.6 28439.6 29159.6 34841.8 34859.7 35721.5 33568.7 35769.5 35982.6 36281.6 36514.5 27406.2 31266.1 31425.7 31743.5 31848.7 21468.6 24340.9 24389.0 24428.1 24552.3 17:40:52 INFO - PID 1643 | 17:40:52 INFO - PID 1643 | [#2] jquery.html Cycles:180 Average:39902.79 Median:21582.85 stddev:117046.04 (542.3%) stddev-sans-first:117336.84 17:40:52 INFO - PID 1643 | Values: 422.7 423.6 433.6 448.4 448.8 18860.9 20745.1 21303.0 21526.7 21533.5 18452.0 20736.0 22731.4 23526.8 23640.8 6169.8 6354.3 6394.0 6397.0 6397.7 6008.6 6285.8 6378.2 6392.4 6483.0 5334.5 6080.1 6329.1 6338.1 6344.4 6223.1 6331.2 6345.1 6348.8 6364.7 5367.4 5537.0 5577.1 5580.7 5618.3 26745.8 26897.9 27222.3 27259.3 27315.9 2026.2 2047.6 2074.8 2083.4 2143.9 15809.7 16149.4 16302.9 16349.6 16666.2 1680.1 1697.4 1713.3 1715.6 1718.5 124701.0 138949.0 141768.0 143389.8 144198.0 10419.0 12041.4 12514.2 12523.0 12704.4 15768.1 15777.4 15784.9 15787.1 15829.3 8442.6 8618.3 8650.2 8711.1 8741.3 8158.7 8166.0 8169.3 8328.6 8330.0 6483.9 6725.5 7806.1 7830.6 7848.2 1829.6 2107.8 2130.5 2131.1 2148.2 946.0 969.0 972.2 972.3 1010.6 16853.7 20889.6 21058.7 21083.2 21210.7 895.7 923.7 965.1 1011.2 1020.5 10009.4 10358.1 10399.0 10435.5 10573.7 680936.0 701178.0 701962.8 707177.0 715995.0 118669.2 135110.0 137487.6 141070.0 170277.0 1095.5 1182.4 1204.5 1237.1 1244.6 18290.1 20386.9 21298.4 21511.9 21632.2 55977.7 61960.7 62512.7 63815.4 63998.4 88009.0 89578.0 89584.1 90010.0 90548.0 8383.9 8396.6 8600.2 8801.1 8891.2 13043.5 13374.3 13558.8 13591.4 13662.8 11371.9 11574.4 11737.9 11854.6 11864.0 10356.7 11156.2 11275.6 11584.8 11666.8 8857.0 9639.6 11344.7 11725.0 12035.2 7447.3 7479.7 8630.4 8807.3 8996.8 9602.8 11880.5 12059.5 12184.0 12221.6 17:40:52 INFO - PID 1643 | 17:40:52 INFO - PID 1643 | [#3] mootools.html Cycles:180 Average:6661.53 Median:3013.14 stddev:4100.20 (136.1%) stddev-sans-first:4092.39 17:40:52 INFO - PID 1643 | Values: 1365.8 1432.5 1436.1 1438.9 1455.8 10278.9 10570.9 10700.4 10710.8 10816.6 8394.7 9032.8 10459.7 10567.2 10642.3 2380.3 2417.9 2420.2 2420.7 2429.8 2353.0 2403.1 2415.4 2417.6 2418.7 2054.5 2382.1 2405.9 2424.8 2427.6 2363.9 2385.1 2396.1 2406.0 2406.6 2305.5 2364.8 2402.8 2418.5 2420.4 10508.8 10585.3 10599.3 10599.8 10624.6 6102.6 6263.0 6308.1 6313.0 6313.5 3925.5 3949.9 3967.4 4005.2 4040.6 1172.4 1280.7 1344.6 1575.8 1577.1 15071.2 15078.8 15087.0 15208.1 15224.3 4533.8 5123.0 5277.4 5334.3 5396.6 11228.3 11281.4 11333.0 11359.0 11365.0 6137.6 6216.4 6232.8 6252.3 6262.7 5562.1 5675.5 5808.2 5838.3 5842.7 3596.5 4162.7 4227.4 4265.4 4329.4 1075.6 1105.9 1230.4 1259.9 1274.0 741.4 748.0 770.8 771.6 808.9 5532.2 6325.8 6716.0 6717.6 6727.9 871.2 898.7 911.3 913.7 914.9 4079.9 4096.2 4138.1 4190.5 4204.2 13461.3 13688.9 13911.0 13923.7 13931.9 12308.8 12719.6 13584.2 13877.7 13877.7 8222.0 10053.7 10264.0 10336.2 10343.2 5019.5 6184.8 6273.5 6379.3 6441.7 12085.7 12360.1 12474.3 12494.4 12664.2 10625.8 12211.8 12465.4 12807.5 13056.7 7673.6 8868.0 9076.4 9076.8 9089.7 8442.4 10061.8 10108.7 10197.5 10231.8 8800.7 8933.3 8987.8 9007.0 9073.5 7377.8 8849.6 8866.2 8876.1 8978.9 6577.2 7540.3 7657.7 7664.0 7684.0 5641.3 5664.2 5739.2 5753.7 5851.3 5682.5 5711.2 5890.4 5961.8 6093.3 17:40:52 INFO - PID 1643 | 17:40:52 INFO - PID 1643 | [#4] prototype.html Cycles:180 Average:5240.62 Median:5809.51 stddev:1572.20 (27.1%) stddev-sans-first:1533.25 17:40:52 INFO - PID 1643 | Values: 354.8 383.9 399.4 399.9 403.2 4491.3 6006.8 6107.1 6213.1 6257.6 5783.0 5930.9 6000.4 6008.1 6012.9 4709.5 4727.6 4740.1 4749.5 4761.4 4585.6 4597.3 4685.6 4726.4 4771.4 4079.6 4691.0 4706.8 4714.3 4725.2 3846.7 4697.5 4716.0 4751.6 4753.9 3749.5 4070.2 4152.9 4173.8 4189.6 4806.9 5361.5 5821.8 5866.9 5897.7 4539.5 5446.8 5461.1 5471.9 5497.9 6195.8 6410.2 6481.5 6522.6 6550.0 3887.6 4272.4 4627.6 4649.8 4663.6 5419.8 6465.9 6572.0 6759.9 6823.2 4780.0 4790.5 4797.8 4811.3 4829.0 4761.0 4888.9 4896.3 4903.7 4920.9 5025.5 5305.9 5327.0 5357.2 5549.9 5797.2 6074.1 6550.9 6575.5 6576.7 1473.8 1516.9 1537.5 1538.6 1550.2 1010.7 1011.5 1019.3 1023.0 1025.9 5370.0 6061.7 6072.9 6109.5 6166.0 5428.7 6543.0 6679.9 6706.4 6756.8 4765.3 6015.5 6088.0 6098.5 6108.1 3268.8 3495.8 3503.3 3532.2 3543.4 5862.9 5912.5 6136.8 6486.8 6644.9 5226.7 5757.6 6342.3 6645.8 6907.8 6341.0 6397.0 6614.4 6628.0 6712.8 5887.7 6385.1 6559.1 6747.2 6756.5 5995.8 6404.6 6581.6 6604.5 6650.2 6502.0 6870.6 6878.4 6944.2 6952.4 4082.5 4358.0 4383.9 4408.9 4434.9 5902.7 6122.4 6433.7 6544.7 6637.7 6435.0 6460.8 6469.6 6478.3 6524.3 5072.8 6012.6 6186.9 6375.8 6470.4 5338.7 5586.5 6331.0 6366.5 6416.6 5599.8 5777.0 6516.6 6538.7 6545.9 6203.0 6262.6 6276.0 6282.6 6297.2 17:40:52 INFO - PID 1643 | 17:40:52 INFO - PID 1643 | [#5] yui.html Cycles:180 Average:19225.05 Median:3094.72 stddev:27255.43 (880.7%) stddev-sans-first:27296.20 17:40:52 INFO - PID 1643 | Values: 651.3 709.3 728.8 730.2 746.5 14876.0 15841.7 15973.0 15974.1 16047.4 12596.9 13180.2 14824.9 14927.8 15260.5 924.4 948.1 949.8 950.6 952.7 914.2 940.7 941.5 950.3 953.5 850.8 881.6 1007.7 1009.7 1017.3 982.5 1003.1 1007.3 1007.4 1010.9 726.2 743.9 751.1 751.6 753.8 15935.2 16347.7 16493.9 16604.1 16878.2 12507.4 14519.5 14577.3 14696.1 14739.8 11886.4 11940.2 11956.8 12148.5 12492.6 2794.9 3015.4 3074.2 3115.3 3140.2 112500.0 114908.0 116387.4 118089.0 120089.4 11268.7 11285.8 11346.9 11393.5 11833.9 21861.7 24434.0 24778.4 25183.5 25222.4 6748.8 7580.7 7713.5 7730.1 7844.0 3637.3 3727.6 3747.6 3750.2 3781.0 4047.1 4177.2 4201.5 4203.8 4207.2 780.6 781.5 787.8 788.9 805.2 466.6 475.3 485.1 513.8 521.1 9688.3 9758.0 9994.5 10019.0 10249.6 546.3 556.2 573.0 574.4 579.5 4021.5 4531.6 4620.0 4626.4 4681.7 58181.0 69282.7 98662.5 99902.0 100791.0 63584.7 71370.3 71436.6 77983.0 78810.0 70627.6 71137.6 72099.0 72710.9 72807.5 8677.6 10241.1 10652.0 10817.8 10848.5 29337.6 33357.3 34654.7 36713.3 39148.2 56126.7 58964.7 61118.7 61543.4 66289.7 13553.8 13954.0 14120.4 14220.5 14311.6 14205.2 14707.8 14818.3 14983.6 15524.8 13265.9 13531.9 13782.6 13827.8 14098.4 13546.5 13854.3 13992.7 14028.7 14270.5 13318.7 13419.4 13513.7 13565.9 14286.3 11211.8 11233.7 11320.5 11362.9 11363.9 7703.0 9971.9 10904.6 11279.3 11607.4 17:40:52 INFO - PID 1643 | -------- Summary: end -------- 17:40:52 INFO - PID 1643 | 17:40:53 INFO - TEST-INFO | 1643: exit 0 17:40:53 INFO - TEST-OK | dromaeo_css | took 1118199ms 17:40:53 INFO - TEST-START | kraken 17:40:53 INFO - operating with platform_type : mac_ 17:40:53 INFO - Initialising browser for kraken test... 17:40:53 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/tmpRdxOEh/profile http://localhost:49242/getInfo.html) 17:40:55 INFO - PID 1652 | 2017-03-21 17:40:55.972 plugin-container[1653:11567] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a37, name = 'com.apple.tsm.portname' 17:40:55 INFO - PID 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:40:55 INFO - PID 1652 | 2017-03-21 17:40:55.975 plugin-container[1653:11567] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4607, name = 'com.apple.CFPasteboardClient' 17:40:55 INFO - PID 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:40:55 INFO - PID 1652 | 2017-03-21 17:40:55.975 plugin-container[1653:11567] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:40:56 INFO - PID 1652 | __metrics Screen width/height:1600/1200 17:40:56 INFO - PID 1652 | colorDepth:24 17:40:56 INFO - PID 1652 | Browser inner width/height: 1024/689 17:40:56 INFO - PID 1652 | __metrics 17:40:56 ERROR - PID 1652 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3350: TypeError: this.tabs is undefined 17:40:56 INFO - TEST-INFO | 1652: exit 0 17:40:56 INFO - Browser initialized. 17:40:56 INFO - Running cycle 1/1 for kraken test... 17:40:56 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/T/tmpRdxOEh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:40:59 INFO - PID 1654 | 2017-03-21 17:40:59.387 plugin-container[1655:11698] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c4b, name = 'com.apple.tsm.portname' 17:40:59 INFO - PID 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:40:59 INFO - PID 1654 | 2017-03-21 17:40:59.387 plugin-container[1655:11698] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x431b, name = 'com.apple.CFPasteboardClient' 17:40:59 INFO - PID 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:40:59 INFO - PID 1654 | 2017-03-21 17:40:59.388 plugin-container[1655:11698] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:41:09 INFO - PID 1654 | RSS: Main: 227192832 17:41:09 INFO - PID 1654 | 17:41:12 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection) 17:41:13 INFO - PID 1654 | RSS: Main: 241831936 17:41:13 INFO - PID 1654 | 17:41:15 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-dft) 17:41:16 INFO - PID 1654 | RSS: Main: 250552320 17:41:16 INFO - PID 1654 | 17:41:19 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-fft) 17:41:20 INFO - PID 1654 | RSS: Main: 253087744 17:41:20 INFO - PID 1654 | 17:41:22 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator) 17:41:22 INFO - PID 1654 | RSS: Main: 255213568 17:41:22 INFO - PID 1654 | 17:41:24 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:41:25 INFO - PID 1654 | RSS: Main: 255631360 17:41:25 INFO - PID 1654 | 17:41:28 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom) 17:41:29 INFO - PID 1654 | RSS: Main: 260800512 17:41:29 INFO - PID 1654 | 17:41:32 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate) 17:41:33 INFO - PID 1654 | RSS: Main: 258928640 17:41:33 INFO - PID 1654 | 17:41:36 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial) 17:41:37 INFO - PID 1654 | RSS: Main: 260046848 17:41:37 INFO - PID 1654 | 17:41:39 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:41:39 INFO - PID 1654 | RSS: Main: 260313088 17:41:39 INFO - PID 1654 | 17:41:41 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:41:42 INFO - PID 1654 | RSS: Main: 260374528 17:41:42 INFO - PID 1654 | 17:41:44 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:41:45 INFO - PID 1654 | RSS: Main: 260435968 17:41:45 INFO - PID 1654 | 17:41:48 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:41:48 INFO - PID 1654 | RSS: Main: 260808704 17:41:48 INFO - PID 1654 | 17:41:52 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:41:52 INFO - PID 1654 | RSS: Main: 260530176 17:41:52 INFO - PID 1654 | 17:41:54 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49242/tests/kraken/driver.html?testName=ai-astar) 17:41:54 INFO - PID 1654 | RSS: Main: 263610368 17:41:54 INFO - PID 1654 | 17:41:54 INFO - PID 1654 | __start_tp_report 17:41:54 INFO - PID 1654 | _x_x_mozilla_page_load 17:41:54 INFO - PID 1654 | _x_x_mozilla_page_load_details 17:41:54 INFO - PID 1654 | |i|pagename|runs| 17:41:54 INFO - PID 1654 | |0;ai-astar;141;174;120;115;116;96;96;166;164;172 17:41:54 INFO - PID 1654 | |1;audio-beat-detection;147;128;149;169;111;116;116;115;149;148 17:41:54 INFO - PID 1654 | |2;audio-dft;196;219;213;217;196;197;197;198;196;198 17:41:54 INFO - PID 1654 | |3;audio-fft;82;57;57;86;77;87;59;58;72;60 17:41:54 INFO - PID 1654 | |4;audio-oscillator;93;70;84;72;71;70;84;70;71;82 17:41:54 INFO - PID 1654 | |5;imaging-gaussian-blur;107;106;138;89;129;138;79;120;137;112 17:41:54 INFO - PID 1654 | |6;imaging-darkroom;105;138;93;141;154;149;153;98;104;149 17:41:54 INFO - PID 1654 | |7;imaging-desaturate;137;141;90;90;89;77;145;145;91;89 17:41:54 INFO - PID 1654 | |8;json-parse-financial;67;65;65;67;66;69;70;68;67;67 17:41:54 INFO - PID 1654 | |9;json-stringify-tinderbox;58;62;57;68;66;85;82;84;49;66 17:41:54 INFO - PID 1654 | |10;stanford-crypto-aes;83;97;107;109;84;85;87;77;104;85 17:41:54 INFO - PID 1654 | |11;stanford-crypto-ccm;144;141;141;143;142;144;147;147;199;139 17:41:54 INFO - PID 1654 | |12;stanford-crypto-pbkdf2;199;190;187;205;245;245;184;213;204;193 17:41:54 INFO - PID 1654 | |13;stanford-crypto-sha256-iterative;68;71;67;69;69;70;65;68;74;70 17:41:54 INFO - PID 1654 | __end_tp_report 17:41:54 INFO - PID 1654 | __start_cc_report 17:41:54 INFO - PID 1654 | _x_x_mozilla_cycle_collect,997 17:41:54 INFO - PID 1654 | __end_cc_report 17:41:54 INFO - PID 1654 | __startTimestamp1490143314757__endTimestamp 17:41:54 INFO - PID 1654 | 17:41:54 INFO - PID 1654 | ------- Summary: start ------- 17:41:54 INFO - PID 1654 | Number of tests: 14 17:41:54 INFO - PID 1654 | 17:41:54 INFO - PID 1654 | [#0] ai-astar Cycles:10 Average:136.00 Median:169.00 stddev:31.17 (18.4%) stddev-sans-first:33.01 17:41:54 INFO - PID 1654 | Values: 141.0 174.0 120.0 115.0 116.0 96.0 96.0 166.0 164.0 172.0 17:41:54 INFO - PID 1654 | 17:41:54 INFO - PID 1654 | [#1] audio-beat-detection Cycles:10 Average:134.80 Median:147.50 stddev:20.02 (13.6%) stddev-sans-first:20.74 17:41:54 INFO - PID 1654 | Values: 147.0 128.0 149.0 169.0 111.0 116.0 116.0 115.0 149.0 148.0 17:41:54 INFO - PID 1654 | 17:41:54 INFO - PID 1654 | [#2] audio-dft Cycles:10 Average:202.70 Median:198.00 stddev:9.55 (4.8%) stddev-sans-first:9.81 17:41:54 INFO - PID 1654 | Values: 196.0 219.0 213.0 217.0 196.0 197.0 197.0 198.0 196.0 198.0 17:41:54 INFO - PID 1654 | 17:41:54 INFO - PID 1654 | [#3] audio-fft Cycles:10 Average:69.50 Median:74.50 stddev:12.66 (17.0%) stddev-sans-first:12.59 17:41:54 INFO - PID 1654 | Values: 82.0 57.0 57.0 86.0 77.0 87.0 59.0 58.0 72.0 60.0 17:41:54 INFO - PID 1654 | 17:41:54 INFO - PID 1654 | [#4] audio-oscillator Cycles:10 Average:76.70 Median:77.00 stddev:8.31 (10.8%) stddev-sans-first:6.39 17:41:54 INFO - PID 1654 | Values: 93.0 70.0 84.0 72.0 71.0 70.0 84.0 70.0 71.0 82.0 17:41:54 INFO - PID 1654 | 17:41:54 INFO - PID 1654 | [#5] imaging-gaussian-blur Cycles:10 Average:115.50 Median:137.50 stddev:20.78 (15.1%) stddev-sans-first:21.81 17:41:54 INFO - PID 1654 | Values: 107.0 106.0 138.0 89.0 129.0 138.0 79.0 120.0 137.0 112.0 17:41:54 INFO - PID 1654 | 17:41:54 INFO - PID 1654 | [#6] imaging-darkroom Cycles:10 Average:128.40 Median:151.00 stddev:25.12 (16.6%) stddev-sans-first:25.18 17:41:54 INFO - PID 1654 | Values: 105.0 138.0 93.0 141.0 154.0 149.0 153.0 98.0 104.0 149.0 17:41:54 INFO - PID 1654 | 17:41:54 INFO - PID 1654 | [#7] imaging-desaturate Cycles:10 Average:109.40 Median:89.00 stddev:28.42 (31.9%) stddev-sans-first:28.33 17:41:54 INFO - PID 1654 | Values: 137.0 141.0 90.0 90.0 89.0 77.0 145.0 145.0 91.0 89.0 17:41:54 INFO - PID 1654 | 17:41:54 INFO - PID 1654 | [#8] json-parse-financial Cycles:10 Average:67.10 Median:67.00 stddev:1.60 (2.4%) stddev-sans-first:1.69 17:41:54 INFO - PID 1654 | Values: 67.0 65.0 65.0 67.0 66.0 69.0 70.0 68.0 67.0 67.0 17:41:54 INFO - PID 1654 | 17:41:54 INFO - PID 1654 | [#9] json-stringify-tinderbox Cycles:10 Average:67.70 Median:67.00 stddev:12.32 (18.4%) stddev-sans-first:12.56 17:41:54 INFO - PID 1654 | Values: 58.0 62.0 57.0 68.0 66.0 85.0 82.0 84.0 49.0 66.0 17:41:54 INFO - PID 1654 | 17:41:54 INFO - PID 1654 | [#10] stanford-crypto-aes Cycles:10 Average:91.80 Median:84.50 stddev:11.43 (13.5%) stddev-sans-first:11.67 17:41:54 INFO - PID 1654 | Values: 83.0 97.0 107.0 109.0 84.0 85.0 87.0 77.0 104.0 85.0 17:41:54 INFO - PID 1654 | 17:41:54 INFO - PID 1654 | [#11] stanford-crypto-ccm Cycles:10 Average:148.70 Median:144.00 stddev:17.86 (12.4%) stddev-sans-first:18.86 17:41:54 INFO - PID 1654 | Values: 144.0 141.0 141.0 143.0 142.0 144.0 147.0 147.0 199.0 139.0 17:41:54 INFO - PID 1654 | 17:41:54 INFO - PID 1654 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:206.50 Median:204.50 stddev:22.14 (10.8%) stddev-sans-first:23.32 17:41:54 INFO - PID 1654 | Values: 199.0 190.0 187.0 205.0 245.0 245.0 184.0 213.0 204.0 193.0 17:41:54 INFO - PID 1654 | 17:41:54 INFO - PID 1654 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:69.50 stddev:2.42 (3.5%) stddev-sans-first:2.54 17:41:54 INFO - PID 1654 | Values: 68.0 71.0 67.0 69.0 69.0 70.0 65.0 68.0 74.0 70.0 17:41:54 INFO - PID 1654 | -------- Summary: end -------- 17:41:54 INFO - PID 1654 | 17:41:55 INFO - TEST-INFO | 1654: exit 0 17:41:55 INFO - TEST-OK | kraken | took 62434ms 17:41:55 INFO - SUITE-END | took 1180s 17:41:55 INFO - Completed test suite (00:19:40) 17:41:55 INFO - javascript benchmark 17:41:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7646.689284511733, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3518.54258946337, 3522.436410174371, 3537.1687653401464, 3570.1788588624618, 3579.0694419450933, 4548.567886050824, 6091.055886337614, 6176.845578860531, 6198.132261483384, 6227.43953044226, 5018.899622007558, 6103.60326578772, 6118.3450802373245, 6199.752009919609, 6219.689015549216, 5476.0, 5509.146082357221, 5544.500994910457, 5595.160725891128, 5648.661080335172, 4611.7232966021975, 5495.42797181833, 5565.777368905239, 5602.075657516505, 5644.096944488862, 5447.319085114361, 5500.4499550045075, 5532.3914369419335, 5563.332400111972, 5576.107822748381, 5488.725563721838, 5511.807086751945, 5540.141278101901, 5543.25166102575, 5555.916661250085, 5421.701806400646, 5449.591280653967, 5456.372517160537, 5461.754221060062, 5467.9453205467835, 5969.432903874168, 6074.119252708377, 6103.87792244157, 6108.480779133779, 6166.013437849922, 6385.233771947396, 6412.61524308543, 6426.1003459515705, 6517.641529715864, 6572.638504882229, 6694.330566943316, 6705.5976641401185, 6713.765018224339, 6717.832054198684, 6727.865442691119, 6199.16311297969, 6261.78083767066, 6278.4035516625845, 6280.937190628127, 6295.685215739195, 6116.518381401602, 6578.0, 6724.966375168093, 6844.931550684529, 6851.828704282433, 6298.685065746694, 6358.205224346957, 6414.486841052704, 6421.133147025185, 6515.250746164157, 5814.912776308359, 6474.4496717778575, 6602.570832895846, 6638.834029149213, 6658.933410665832, 6563.737450502022, 6568.901466478007, 6570.342965703487, 6574.638394888231, 6605.636689982001, 6349.904751428732, 6432.844996925988, 6471.644059576768, 6600.5049621278595, 6623.536352455379, 5202.0, 5252.133397989365, 5275.0, 5297.417284098746, 5329.987302412529, 4689.343491911135, 4689.906201875943, 4711.269753188261, 4724.267738500538, 4744.881377965578, 6225.159603453566, 6282.685865706696, 6305.527085468608, 6307.684615769285, 6321.051842223611, 6406.615603063831, 6512.218533775977, 6586.176727909012, 6590.176227971504, 6648.700808463631, 6209.441150296495, 6241.500679945593, 6259.374062593704, 6268.49852011838, 6271.717772700239, 4934.284528743384, 5851.385604511465, 5872.941270587325, 5873.853153671107, 5881.676507792027, 6639.568428052161, 6777.864442711019, 6788.321167883172, 6800.897986530107, 6811.89782153278, 6650.235222949423, 6651.767188148391, 6670.933290667225, 6715.56348837324, 6739.224989126314, 6837.418819400406, 6840.589564626139, 6849.1096157499205, 6860.073890024983, 6891.483138764513, 6347.428731414195, 6424.903626445701, 6483.708233129426, 6533.118029066205, 6551.574147680385, 6565.638889861103, 6659.667016649245, 6678.365555272241, 6679.0, 6709.731610735711, 6281.59169653971, 6436.227652681521, 6449.12936753551, 6450.774222902176, 6480.287168411565, 5740.68426236561, 6211.819754246679, 6242.843928901813, 6393.328700486382, 6399.392057754506, 6206.224221972254, 6340.239171299474, 6353.332900045429, 6391.10524526576, 6430.324815894263, 6488.870222595428, 6492.610443373413, 6503.0, 6504.707288171949, 6510.544261901621, 6199.659018754011, 6221.844453888508, 6296.496280297473, 6340.524460665561, 6343.365663433619], "value": 6038.5765367715, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [737.2958824322773, 810.116972499975, 828.2338836576167, 1256.2336974445593, 1273.8853503184712, 37825.24349513008, 38859.02852428691, 38993.0, 39007.41488877669, 39040.21919561607, 38768.0, 38814.22371552567, 39015.0, 39065.41401878967, 39130.0, 7908.0, 8047.597620119, 8368.372372072088, 8622.180892815173, 8642.351823613255, 6855.862882742342, 8679.349048821332, 8682.652693892269, 8697.304215662763, 8713.0, 8648.178423049832, 8735.694250701226, 8742.038375778659, 8745.125487451267, 8746.825063498727, 8681.826363472726, 8713.302935765123, 8717.694880679146, 8725.650973961066, 8743.431676940978, 8568.914310856937, 8572.357073219533, 8578.613962371646, 8626.137386261387, 8628.784280392978, 38643.420348694795, 38941.8317450477, 38958.80520597407, 38961.41557876634, 38985.0, 3002.549617557362, 3024.2892920163745, 3036.316828713544, 3042.680518545543, 3047.420990011891, 28383.716162838315, 28526.71473285261, 28598.285042873886, 28605.57091643627, 29532.704672953427, 2777.4167424840807, 2778.0, 2785.749282564579, 2802.397484540813, 2827.3073097091346, 297822.0, 315086.0, 318131.0, 320191.0, 321275.78724212694, 46123.61629151131, 51126.744366278675, 51167.48832511702, 51221.0, 51464.48535514672, 49773.75113124411, 53370.19944700832, 53391.73304133455, 53627.46372536303, 53751.0, 14279.500217492337, 14696.338664760111, 14714.632134196516, 14716.632084197981, 14721.779173312409, 11924.76150477003, 11959.162858599988, 11968.0, 11972.16194866351, 12013.27920324766, 11975.221610595283, 12488.000959923183, 12925.870741292654, 13598.796018059737, 14028.0, 5417.510184699239, 5719.685417302088, 5973.820785376446, 6044.274687037584, 6100.786472473442, 875.3522393428944, 987.456898705709, 988.1748739802346, 1010.751721623794, 1014.5181039006413, 22000.88999554992, 22178.556428871656, 22763.317100487013, 23881.381046538547, 24483.632745508832, 913.8355096082769, 1069.1767339148812, 1116.1963386361806, 1119.6081371519904, 1120.7030137013699, 11374.31754094757, 11824.645260642195, 12503.87496125027, 12513.3743312834, 12540.122191446693, 456341.0, 458820.0, 459308.0, 460478.39521605027, 461068.0, 45755.08489830251, 54965.17552236719, 55491.0, 56674.7166264166, 57288.85422291614, 1294.4110429754628, 1415.8796502297214, 1417.2134465371817, 1440.2510694439043, 1448.2107251547932, 23035.308940731804, 24902.875485622455, 28809.27976800513, 28899.0, 29131.417371652024, 32896.0, 37193.628063719014, 37420.877373678835, 37436.0, 37607.62392376041, 385295.0, 386513.0, 389259.0, 390606.0, 390861.0, 32813.67186328106, 33295.83464578825, 33476.83261583676, 33497.48276431037, 33527.83236083804, 41599.168016640106, 41840.0, 42263.57736422597, 43341.0, 43468.91327716832, 34841.12897177591, 35015.299694005465, 35169.29661406706, 35733.57065717446, 36172.638273616925, 28439.573406399333, 29159.562606560496, 34841.825790870884, 34859.65140348564, 35721.46417803787, 33568.66431335655, 35769.46345804763, 35982.64017359898, 36281.63718362783, 36514.45228321524, 27406.228147178066, 31266.144736319526, 31425.685743142276, 31743.523847142773, 31848.681513184572, 21468.57062858703, 24340.878295608407, 24389.02443902224, 24428.145014924394, 24552.263432097065], "value": 17861.156322927098, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [422.69988308301106, 423.5922007450064, 433.61408346571545, 448.4192970103715, 448.82047181127547, 18860.905695471538, 20745.06647200876, 21303.04136313866, 21526.677099843513, 21533.46166345842, 18452.0, 20736.0, 22731.431714207152, 23526.823658817077, 23640.76359236407, 6169.814905552829, 6354.332795056522, 6393.968030159843, 6397.040443933401, 6397.744090236408, 6008.575112186056, 6285.842853928642, 6378.234611846562, 6392.424681778639, 6482.967585162068, 5334.546563542103, 6080.087986801971, 6329.113924050636, 6338.080978258173, 6344.3655634436645, 6223.097650840626, 6331.2085989251345, 6345.111684364193, 6348.777792777254, 6364.681765911686, 5367.382750983647, 5537.0, 5577.107662773937, 5580.720963951827, 5618.297712785902, 26745.79643916009, 26897.86551067232, 27222.319442014108, 27259.318517037034, 27315.907363705428, 2026.230032587622, 2047.6109539187655, 2074.8132668059948, 2083.395815213586, 2143.946401339979, 15809.683806323808, 16149.354025838953, 16302.918485407616, 16349.59126021847, 16666.166691665367, 1680.1011458869446, 1697.3634886917405, 1713.2632967823831, 1715.5968347438343, 1718.535995281267, 124701.0, 138949.0, 141768.0, 143389.8491522628, 144198.0, 10419.0, 12041.397930103634, 12514.249145051326, 12523.0, 12704.364781760874, 15768.132752698712, 15777.447789327318, 15784.92107539455, 15787.131707755954, 15829.287682054104, 8442.62008209632, 8618.310535157172, 8650.178233067849, 8711.08533603975, 8741.256993155526, 8158.673653053811, 8165.95917020423, 8169.346452283803, 8328.583570821434, 8330.04244002659, 6483.870322593616, 6725.495587830932, 7806.063272407234, 7830.647620857075, 7848.175941526171, 1829.5883426228993, 2107.766956330564, 2130.5099827039867, 2131.1155870313955, 2148.172953412916, 946.0, 968.9515524223901, 972.1590823937244, 972.2853702528636, 1010.6109147978082, 16853.747193792104, 20889.582208355747, 21058.68411973791, 21083.15667373288, 21210.681839772416, 895.6909866096187, 923.7044145873256, 965.1217392173229, 1011.1506334678905, 1020.5203554329453, 10009.449480278654, 10358.067773900235, 10399.0, 10435.478226088817, 10573.735656608493, 680936.0, 701177.9882201112, 701962.8421360083, 707177.0, 715995.0, 118669.21996169892, 135110.0, 137487.6251237495, 141070.0, 170276.99999999753, 1095.45774841454, 1182.4442512019336, 1204.476052916984, 1237.0845574274972, 1244.6266120164096, 18290.085495725427, 20386.898065509577, 21298.36104916855, 21511.892440537697, 21632.24287149942, 55977.72011139918, 61960.69019654873, 62512.687436562526, 63815.36184638094, 63998.36001639924, 88009.0, 89578.0, 89584.10415895758, 90010.0, 90548.0, 8383.874241886499, 8396.580170991549, 8600.22597966186, 8801.07588703177, 8891.19979201875, 13043.543475978295, 13374.331283435984, 13558.79661805054, 13591.388387522387, 13662.795058074336, 11371.943140284246, 11574.37944801263, 11737.88262117402, 11854.585089521825, 11864.0, 10356.689299321033, 11156.163287753614, 11275.605353812578, 11584.768304633692, 11666.824997624874, 8856.955715221382, 9639.614415423304, 11344.716382090184, 11725.003374712904, 12035.157538972539, 7447.255274472726, 7479.738209162653, 8630.352723545884, 8807.339449541181, 8996.820063598821, 9602.759931001781, 11880.524779008743, 12059.457324420247, 12184.0, 12221.572244971383], "value": 10316.908908867968, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1365.8429280632727, 1432.4556668465982, 1436.1311406599007, 1438.8561093930325, 1455.7597996330603, 10278.948605256972, 10570.894291057088, 10700.357978521295, 10710.785784284319, 10816.567337306498, 8394.664213431455, 9032.819343613124, 10459.73850653734, 10567.207459440535, 10642.308249963748, 2380.250221180327, 2417.8791060446997, 2420.2376251480814, 2420.721617014048, 2429.757024297574, 2352.9882350588223, 2403.110848985869, 2415.4444477770126, 2417.5527527407485, 2418.6855708757835, 2054.5069183396026, 2382.118616112032, 2405.867677277749, 2424.7696468835434, 2427.587310157269, 2363.8818059096975, 2385.117506522589, 2396.1254142238045, 2406.03758496601, 2406.5547873643345, 2305.4697419593585, 2364.775346342112, 2402.8438151520095, 2418.5404773093055, 2420.3707036170545, 10508.84236736442, 10585.311954722918, 10599.258051936367, 10599.788004239872, 10624.575016999312, 6102.572819902609, 6263.0, 6308.116863639094, 6313.0, 6313.494920406402, 3925.450436938831, 3949.861754838567, 3967.4247234151176, 4005.198960207941, 4040.5555388907196, 1172.4313707851686, 1280.737448822989, 1344.5529136970717, 1575.8109026916843, 1577.0823975644964, 15071.246437678072, 15078.793696504254, 15087.0, 15208.08751474904, 15224.314905829264, 4533.818647254139, 5122.974385128051, 5277.366715994105, 5334.306540149756, 5396.622236443412, 11228.270162439416, 11281.435928203557, 11332.980031797179, 11359.0, 11365.0, 6137.5703700741415, 6216.409441103088, 6232.750689972441, 6252.3122456529745, 6262.718177682015, 5562.054450743383, 5675.489205971482, 5808.157817116579, 5838.328592211865, 5842.707864606838, 3596.514470546495, 4162.666986641061, 4227.365895115696, 4265.3815196796295, 4329.393884856123, 1075.596651255779, 1105.8894110589038, 1230.446299165379, 1259.8803113704184, 1273.961781146567, 741.4365082537311, 747.986478321866, 770.7995921060565, 771.5872008475438, 808.9191080891982, 5532.225488431623, 6325.778597749057, 6715.9590263509235, 6717.563358381787, 6727.865442691119, 871.172386233081, 898.7034278688018, 911.3256190419042, 913.6756451459636, 914.9021174590519, 4079.8776036718946, 4096.160287141129, 4138.089620283533, 4190.497140343117, 4204.2432362175105, 13461.326933653474, 13688.863111368759, 13911.0, 13923.651908702364, 13931.860681393056, 12308.753824923451, 12719.618411447671, 13584.204274944395, 13877.653058673613, 13877.653058673613, 8221.958890205511, 10053.69838904834, 10264.0, 10336.224783141295, 10343.189941760162, 5019.472955339783, 6184.81445556634, 6273.52948528853, 6379.298277189413, 6441.742330306735, 12085.697857553632, 12360.134790564574, 12474.251544907334, 12494.43775030144, 12664.176828506117, 10625.840612390975, 12211.755764884474, 12465.376731163587, 12807.487700491876, 13056.738865222833, 7673.61631918413, 8868.0, 9076.364654474124, 9076.773080673036, 9089.681861134828, 8442.366822488215, 10061.798764024825, 10108.747281317732, 10197.490125493547, 10231.795364092824, 8800.735977920673, 8933.28533717288, 8987.820243595223, 9006.954965225132, 9073.45559266446, 7377.77866664001, 8849.646014159362, 8866.246369058445, 8876.112388761072, 8978.86531702038, 6577.243616983917, 7540.3213710766295, 7657.655405506877, 7664.0, 7684.001079859582, 5641.26663533738, 5664.207011018543, 5739.167820665896, 5753.741081651419, 5851.297844258716, 5682.516986056232, 5711.171880077449, 5890.381509941394, 5961.791337303173, 6093.329733729198], "value": 5113.346604673328, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.7889006041406, 383.9289731399691, 399.38694104549523, 399.93001224785667, 403.2338556742188, 4491.25894227452, 6006.7897623583185, 6107.0532868376595, 6213.130161777355, 6257.593256438334, 5783.033768518702, 5930.940690593093, 6000.389830423758, 6008.128821320905, 6012.947734146529, 4709.481956984729, 4727.621790256771, 4740.123077230706, 4749.453812811519, 4761.357216775743, 4585.610223131038, 4597.264437689971, 4685.5548722871445, 4726.432828060638, 4771.40158047053, 4079.551249362568, 4690.976545117287, 4706.811727530895, 4714.3164241185, 4725.196716558176, 3846.7499612525376, 4697.459792123898, 4716.009637976029, 4751.643626727975, 4753.928691069636, 3749.4750734897134, 4070.206309769596, 4152.854650087233, 4173.768738222232, 4189.560096189917, 4806.8798280043275, 5361.517463428271, 5821.8253452396075, 5866.911996320058, 5897.734601942923, 4539.500654927955, 5446.809361672323, 5461.0716178249795, 5471.917921231145, 5497.890042199134, 6195.7521699131985, 6410.1987251593555, 6481.48148148147, 6522.608643481406, 6550.0, 3887.5723670396233, 4272.444582204324, 4627.5603817637275, 4649.814007439699, 4663.580277775017, 5419.783208671648, 6465.900796864545, 6572.0141978703095, 6759.898601520932, 6823.249442561314, 4780.0, 4790.473047964721, 4797.808087676523, 4811.291991343092, 4829.0, 4760.95239047612, 4888.902221955612, 4896.290037944478, 4903.730294833818, 4920.901581968341, 5025.522575355335, 5305.867353316198, 5327.0, 5357.249985002103, 5549.890021995617, 5797.188393624896, 6074.11702372266, 6550.901736473957, 6575.473962083021, 6576.671166441659, 1473.8010368600317, 1516.9317380717894, 1537.49325660853, 1538.5999640093432, 1550.2095080182407, 1010.7068950004564, 1011.5195282241024, 1019.3476175247847, 1022.974425639365, 1025.9435731034864, 5370.0, 6061.727222275008, 6072.937235983685, 6109.480694140959, 6165.969170154211, 5428.701421421781, 6542.988426665337, 6679.931211006216, 6706.396424321834, 6756.7972960810275, 4765.332853400527, 6015.54883383748, 6087.96956015226, 6098.54260930432, 6108.083787431832, 3268.7711860170034, 3495.807730574843, 3503.2515208726927, 3532.1875968527384, 3543.4153364695053, 5862.941370586324, 5912.4627596824275, 6136.834001539783, 6486.772962946368, 6644.940068578756, 5226.686398816008, 5757.625754325955, 6342.270638876496, 6645.833854153685, 6907.827304317332, 6341.048842673636, 6396.976483762575, 6614.371634694792, 6628.017392173541, 6712.791697494498, 5887.735051922759, 6385.074164246065, 6559.147310849559, 6747.190337159573, 6756.459483241427, 5995.820125396245, 6404.583702059351, 6581.572197807127, 6604.537682362381, 6650.168728908887, 6501.967490162708, 6870.62211578368, 6878.449724022166, 6944.166699995831, 6952.44380449573, 4082.530508991504, 4358.0, 4383.868483945486, 4408.867733967986, 4434.871261794421, 5902.704864756831, 6122.387761223842, 6433.678316084271, 6544.738210471528, 6637.701303441453, 6435.03474478832, 6460.773872914613, 6469.644169570531, 6478.2550006749825, 6524.347565243438, 5072.797088116582, 6012.609180403259, 6186.876262474635, 6375.776847810304, 6470.35296470368, 5338.706371149624, 5586.525205298749, 6331.0, 6366.522510811615, 6416.550841441054, 5599.796043850592, 5776.971115144397, 6516.6415847128865, 6538.738450462119, 6545.8690826184165, 6203.0, 6262.624242545462, 6275.968620157053, 6282.6440084968135, 6297.244330680348], "value": 4748.018658122122, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [651.2868409092044, 709.3183599369053, 728.8469421421502, 730.200430528571, 746.5259560179285, 14876.033057851231, 15841.683166336696, 15973.0, 15974.121423321712, 16047.358105675774, 12596.93701531491, 13180.209187448736, 14824.851751482482, 14927.77608335873, 15260.542183734506, 924.3529529329479, 948.0661548374845, 949.7862980829327, 950.5579905344014, 952.6618050592009, 914.2183433164648, 940.6613619097119, 941.472775245861, 950.3442624589046, 953.4708236928502, 850.7830503221701, 881.5636260051284, 1007.6775431861807, 1009.6920439266021, 1017.2675673515057, 982.4891056650501, 1003.1473247739436, 1007.3200589602026, 1007.4459047523833, 1010.8534262531965, 726.150404027284, 743.8958545803591, 751.1399447632431, 751.5640928261649, 753.8266198774313, 15935.203239837962, 16347.673046539121, 16493.917530412393, 16604.08677522736, 16878.156092195342, 12507.437165327583, 14519.491817786327, 14577.344019519147, 14696.130402843182, 14739.778903316459, 11886.40567971598, 11940.164188506807, 11956.820647690292, 12148.514059437612, 12492.625221243377, 2794.8820471811237, 3015.366772977677, 3074.169974107001, 3115.2679120406688, 3140.1678555182893, 112500.0, 114908.0, 116387.41806290999, 118089.0, 120089.39955300256, 11268.661940141808, 11285.774284514428, 11346.94326528362, 11393.544258229578, 11833.940830295965, 21861.67207491857, 24434.0, 24778.380540486633, 25183.496330073296, 25222.369440764127, 6748.831279218059, 7580.734674286374, 7713.460057796013, 7730.072391313079, 7844.0, 3637.3452778499595, 3727.6272372762505, 3747.6065013173225, 3750.1562148516364, 3780.9621903781162, 4047.0799014606596, 4177.227212965611, 4201.516825565038, 4203.810828512725, 4207.179599978036, 780.5667854340782, 781.4881252779438, 787.8424315136996, 788.8580055590049, 805.2229598437536, 466.6266986410858, 475.28895974491553, 485.09045539613226, 513.8407093800934, 521.0750917122062, 9688.32181747271, 9757.951210244046, 9994.500274986221, 10019.048190421898, 10249.641262555775, 546.3007350591249, 556.2018503447566, 572.9570282228849, 574.3940143149018, 579.5305802300066, 4021.4718407005153, 4531.614812740954, 4619.976900115478, 4626.444826620827, 4681.695689780154, 58181.0, 69282.65358673275, 98662.50668746754, 99902.0, 100790.99209007816, 63584.68207658932, 71370.2862971374, 71436.64281678558, 77983.0, 78810.0, 70627.64686176639, 71137.57724845473, 72098.99999999895, 72710.90933636, 72807.45173918888, 8677.566121694017, 10241.129503991946, 10652.0, 10817.837732433862, 10848.457577120955, 29337.559936601396, 33357.33285334328, 34654.653453465144, 36713.265734685694, 39148.217035658556, 56126.719366402904, 58964.70517647384, 61118.694406527684, 61543.38456615376, 66289.66855165693, 13553.839109748524, 13953.953453491233, 14120.435182592992, 14220.502282420066, 14311.57065288043, 14205.218712970473, 14707.779383309473, 14818.333175006936, 14983.625409364853, 15524.84475155234, 13265.933670331586, 13531.932340338235, 13782.586522404345, 13827.79258311106, 14098.436062557383, 13546.458141674617, 13854.30728463593, 13992.650183745487, 14028.719425611635, 14270.500532481314, 13318.667033324244, 13419.396127174105, 13513.662158446117, 13565.932170339085, 14286.28568571588, 11211.831822522505, 11233.71915702114, 11320.490577924178, 11362.886371136183, 11363.886361136614, 7702.961485192538, 9971.850422243528, 10904.61833835812, 11279.32324060559, 11607.36159511235], "value": 7399.401990205831, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1623.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 174.0, 120.0, 115.0, 116.0, 96.0, 96.0, 166.0, 164.0, 172.0], "value": 136.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 128.0, 149.0, 169.0, 111.0, 116.0, 116.0, 115.0, 149.0, 148.0], "value": 134.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 219.0, 213.0, 217.0, 196.0, 197.0, 197.0, 198.0, 196.0, 198.0], "value": 202.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 57.0, 57.0, 86.0, 77.0, 87.0, 59.0, 58.0, 72.0, 60.0], "value": 69.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 70.0, 84.0, 72.0, 71.0, 70.0, 84.0, 70.0, 71.0, 82.0], "value": 76.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 106.0, 138.0, 89.0, 129.0, 138.0, 79.0, 120.0, 137.0, 112.0], "value": 115.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 138.0, 93.0, 141.0, 154.0, 149.0, 153.0, 98.0, 104.0, 149.0], "value": 128.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 141.0, 90.0, 90.0, 89.0, 77.0, 145.0, 145.0, 91.0, 89.0], "value": 109.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 65.0, 67.0, 66.0, 69.0, 70.0, 68.0, 67.0, 67.0], "value": 67.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 62.0, 57.0, 68.0, 66.0, 85.0, 82.0, 84.0, 49.0, 66.0], "value": 67.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 97.0, 107.0, 109.0, 84.0, 85.0, 87.0, 77.0, 104.0, 85.0], "value": 91.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 141.0, 141.0, 143.0, 142.0, 144.0, 147.0, 147.0, 199.0, 139.0], "value": 148.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 190.0, 187.0, 205.0, 245.0, 245.0, 184.0, 213.0, 204.0, 193.0], "value": 206.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 71.0, 67.0, 69.0, 69.0, 70.0, 65.0, 68.0, 74.0, 70.0], "value": 69.1, "unit": "score"}]}]} 17:41:56 INFO - Return code: 0 17:41:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:41:56 ERROR - # TBPL SUCCESS # 17:41:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:41:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:41:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:41:56 INFO - 2017-03-21 17:41:56.100 screenresolution[1659:12087] starting screenresolution argv=screenresolution get 17:41:56 INFO - 2017-03-21 17:41:56.103 screenresolution[1659:12087] Display 0: 1600x1200x32@60 17:41:56 INFO - 2017-03-21 17:41:56.109 screenresolution[1660:12090] starting screenresolution argv=screenresolution list 17:41:56 INFO - Available Modes on Display 0 17:41:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:41:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:41:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:41:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:41:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:41:56 INFO - Intel Iris: 17:41:56 INFO - Chipset Model: Intel Iris 17:41:56 INFO - Type: GPU 17:41:56 INFO - Bus: Built-In 17:41:56 INFO - VRAM (Dynamic, Max): 1536 MB 17:41:56 INFO - Vendor: Intel (0x8086) 17:41:56 INFO - Device ID: 0x0a2e 17:41:56 INFO - Revision ID: 0x0009 17:41:56 INFO - Displays: 17:41:56 INFO - Display: 17:41:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:41:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:41:56 INFO - Display Serial Number: 1600x1200 60 17:41:56 INFO - Main Display: Yes 17:41:56 INFO - Mirror: Off 17:41:56 INFO - Online: Yes 17:41:56 INFO - Rotation: Supported 17:41:56 INFO - Return code: 0 17:41:56 INFO - Running post-action listener: _resource_record_post_action 17:41:56 INFO - [mozharness: 2017-03-22 00:41:56.355595Z] Finished run-tests step (success) 17:41:56 INFO - Running post-run listener: _resource_record_post_run 17:41:56 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 34374144; Write bytes: 516199936; Read time: 323; Write time: 1617 17:41:56 INFO - TinderboxPrint: CPU usage
54.2% 17:41:56 INFO - TinderboxPrint: I/O read bytes / time
34,374,144 / 323 17:41:56 INFO - TinderboxPrint: I/O write bytes / time
516,199,936 / 1,617 17:41:56 INFO - TinderboxPrint: CPU idle
2,202.1 (45.8%) 17:41:56 INFO - TinderboxPrint: CPU system
966.0 (20.1%) 17:41:56 INFO - TinderboxPrint: CPU user
1,637.6 (34.1%) 17:41:56 INFO - TinderboxPrint: Swap in / out
240,984,064 / 0 17:41:56 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 204071424; Write bytes: 202925568; Read time: 15711; Write time: 407 17:41:56 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 32526848; Write bytes: 302469120; Read time: 305; Write time: 1176 17:41:56 INFO - Running post-run listener: _upload_blobber_files 17:41:56 INFO - Blob upload gear active. 17:41:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:41:56 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 17:41:56 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'] 17:41:56 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 17:41:57 INFO - (blobuploader) - INFO - Open directory for files ... 17:41:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:41:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:41:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:41:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:41:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:41:58 INFO - (blobuploader) - INFO - Done attempting. 17:41:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:41:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:41:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:41:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:41:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:41:59 INFO - (blobuploader) - INFO - Done attempting. 17:41:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:41:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:41:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:42:00 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:42:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:42:00 INFO - (blobuploader) - INFO - Done attempting. 17:42:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:42:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:42:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:42:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:42:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:42:02 INFO - (blobuploader) - INFO - Done attempting. 17:42:02 INFO - (blobuploader) - INFO - Iteration through files over. 17:42:02 INFO - Return code: 0 17:42:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:42:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:42:02 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce601c571a92cd8f647e68df5dcaa29a7675aa1b12c0661776918eee146ab18d0c37b89d790376fccaa2104ded5108474d67a93244518dc6581b8f69f6ed593c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bfbe63407620975f61502001dc2c71633e4d517c4791ee6f34c6957aa4f5ae7669c46ed919c860c1f141a36b35f41707080d2a90b3337fca33a2d053ea18239e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/252b7abc7895015bf01e0ef532d0f6cb3af54a41ff9b0e0657c2f99e160716b7cfbd36152aa0789b159afb7318de52dd88a9f7f7892a4e3ffdea3d21b5213af4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4bd61a106978da153165116f05af38dffb8007629444b0ed95b5bc2284ddba4b2820046f6c207c4d330bc22826aaa752e87bf447ec07ccfe241e1b3503c1ed4c"} 17:42:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:42:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:42:02 INFO - Contents: 17:42:02 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce601c571a92cd8f647e68df5dcaa29a7675aa1b12c0661776918eee146ab18d0c37b89d790376fccaa2104ded5108474d67a93244518dc6581b8f69f6ed593c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bfbe63407620975f61502001dc2c71633e4d517c4791ee6f34c6957aa4f5ae7669c46ed919c860c1f141a36b35f41707080d2a90b3337fca33a2d053ea18239e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/252b7abc7895015bf01e0ef532d0f6cb3af54a41ff9b0e0657c2f99e160716b7cfbd36152aa0789b159afb7318de52dd88a9f7f7892a4e3ffdea3d21b5213af4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4bd61a106978da153165116f05af38dffb8007629444b0ed95b5bc2284ddba4b2820046f6c207c4d330bc22826aaa752e87bf447ec07ccfe241e1b3503c1ed4c"} 17:42:02 INFO - Running post-run listener: copy_logs_to_upload_dir 17:42:02 INFO - Copying logs to upload dir... 17:42:02 INFO - mkdir: /builds/slave/test/build/upload/logs 17:42:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1285.326985 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-03-21 17:42:02.652494) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-21 17:42:02.656323) ========= 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.imdrghlOgd/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.YnZopf76ot/Listeners TMPDIR=/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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/ce601c571a92cd8f647e68df5dcaa29a7675aa1b12c0661776918eee146ab18d0c37b89d790376fccaa2104ded5108474d67a93244518dc6581b8f69f6ed593c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bfbe63407620975f61502001dc2c71633e4d517c4791ee6f34c6957aa4f5ae7669c46ed919c860c1f141a36b35f41707080d2a90b3337fca33a2d053ea18239e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/252b7abc7895015bf01e0ef532d0f6cb3af54a41ff9b0e0657c2f99e160716b7cfbd36152aa0789b159afb7318de52dd88a9f7f7892a4e3ffdea3d21b5213af4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4bd61a106978da153165116f05af38dffb8007629444b0ed95b5bc2284ddba4b2820046f6c207c4d330bc22826aaa752e87bf447ec07ccfe241e1b3503c1ed4c"} build_url:https://queue.taskcluster.net/v1/task/bzwaR3AHTROGsrH592UvYA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011102 build_url: 'https://queue.taskcluster.net/v1/task/bzwaR3AHTROGsrH592UvYA/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/ce601c571a92cd8f647e68df5dcaa29a7675aa1b12c0661776918eee146ab18d0c37b89d790376fccaa2104ded5108474d67a93244518dc6581b8f69f6ed593c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bfbe63407620975f61502001dc2c71633e4d517c4791ee6f34c6957aa4f5ae7669c46ed919c860c1f141a36b35f41707080d2a90b3337fca33a2d053ea18239e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/252b7abc7895015bf01e0ef532d0f6cb3af54a41ff9b0e0657c2f99e160716b7cfbd36152aa0789b159afb7318de52dd88a9f7f7892a4e3ffdea3d21b5213af4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4bd61a106978da153165116f05af38dffb8007629444b0ed95b5bc2284ddba4b2820046f6c207c4d330bc22826aaa752e87bf447ec07ccfe241e1b3503c1ed4c"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-21 17:42:02.696377) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 17:42:02.696737) ========= 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.imdrghlOgd/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.YnZopf76ot/Listeners TMPDIR=/var/folders/js/rwfvb6856vj5t4gxv45w5yv800000w/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.005209 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 17:42:02.745453) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-21 17:42:02.745940) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-21 17:42:02.746440) ========= ========= Total master_lag: 0.20 =========