builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0079 starttime: 1486148008.91 results: success (0) buildid: 20170203093727 builduid: aa5e83bf318542579d67277c67d7a09c revision: bf15d4078c2a6db7df37ab466d28a1e075c9eb4d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-03 10:53:28.911297) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-03 10:53:28.911757) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-03 10:53:28.912028) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-03 10:53:28.938177) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 10:53:28.938450) ========= 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.8JQk8pwnOO/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.CWwUEMB98p/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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-02-03 10:53:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 151M=0s 2017-02-03 10:53:29 (151 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.139246 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 10:53:29.104223) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 10:53:29.104518) ========= 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.8JQk8pwnOO/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.CWwUEMB98p/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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.028423 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 10:53:29.153588) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-03 10:53:29.153890) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev bf15d4078c2a6db7df37ab466d28a1e075c9eb4d --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 bf15d4078c2a6db7df37ab466d28a1e075c9eb4d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8JQk8pwnOO/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.CWwUEMB98p/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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-02-03 10:53:29,260 truncating revision to first 12 chars 2017-02-03 10:53:29,260 Setting DEBUG logging. 2017-02-03 10:53:29,260 attempt 1/10 2017-02-03 10:53:29,260 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/bf15d4078c2a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-03 10:53:31,485 unpacking tar archive at: mozilla-central-bf15d4078c2a/testing/mozharness/ program finished with exit code 0 elapsedTime=2.485639 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-03 10:53:31.665475) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-03 10:53:31.665775) ========= script_repo_revision: bf15d4078c2a6db7df37ab466d28a1e075c9eb4d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-03 10:53:31.666143) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-03 10:53:31.667419) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-03 10:53:31.688115) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2017-02-03 10:53:31.688391) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.8JQk8pwnOO/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.CWwUEMB98p/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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 10:53:31 INFO - MultiFileLogger online at 20170203 10:53:31 in /builds/slave/test 10:53:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:53:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:53:31 INFO - {'append_to_log': False, 10:53:31 INFO - 'base_work_dir': '/builds/slave/test', 10:53:31 INFO - 'blob_upload_branch': 'Firefox', 10:53:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:53:31 INFO - 'branch': 'Firefox', 10:53:31 INFO - 'buildbot_json_path': 'buildprops.json', 10:53:31 INFO - 'config_files': ('talos/mac_config.py',), 10:53:31 INFO - 'default_actions': ('clobber', 10:53:31 INFO - 'read-buildbot-config', 10:53:31 INFO - 'download-and-extract', 10:53:31 INFO - 'populate-webroot', 10:53:31 INFO - 'create-virtualenv', 10:53:31 INFO - 'install', 10:53:31 INFO - 'run-tests'), 10:53:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:53:31 INFO - 'download_minidump_stackwalk': True, 10:53:31 INFO - 'download_symbols': 'ondemand', 10:53:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:53:31 INFO - 'tooltool.py': '/tools/tooltool.py', 10:53:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:53:31 INFO - '/tools/misc-python/virtualenv.py')}, 10:53:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:53:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:53:31 INFO - 'installer_path': 'installer.exe', 10:53:31 INFO - 'log_level': 'info', 10:53:31 INFO - 'log_name': 'talos', 10:53:31 INFO - 'log_to_console': True, 10:53:31 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:53:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:53:31 INFO - 'opt_config_files': (), 10:53:31 INFO - 'pip_index': False, 10:53:31 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:53:31 INFO - 'cmd': ('bash', 10:53:31 INFO - '-c', 10:53:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:53:31 INFO - 'enabled': True, 10:53:31 INFO - 'halt_on_failure': False, 10:53:31 INFO - 'name': 'check_screen_resolution'},), 10:53:31 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:53:31 INFO - 'cmd': ('bash', 10:53:31 INFO - '-c', 10:53:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:53:31 INFO - 'enabled': True, 10:53:31 INFO - 'halt_on_failure': False, 10:53:31 INFO - 'name': 'check_screen_resolution'},), 10:53:31 INFO - 'run_cmd_checks_enabled': True, 10:53:31 INFO - 'sps_profile': False, 10:53:31 INFO - 'sps_profile_interval': 0, 10:53:31 INFO - 'suite': 'dromaeojs', 10:53:31 INFO - 'system_bits': '32', 10:53:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:53:31 INFO - 'title': 't-yosemite-r7-0079', 10:53:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:53:31 INFO - 'use_talos_json': True, 10:53:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:53:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:53:31 INFO - 'work_dir': 'build'} 10:53:31 INFO - [mozharness: 2017-02-03 18:53:31.902888Z] Running clobber step. 10:53:31 INFO - Running pre-action listener: _resource_record_pre_action 10:53:31 INFO - Running main action method: clobber 10:53:31 INFO - rmtree: /builds/slave/test/build 10:53:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:53:34 INFO - Running post-action listener: _resource_record_post_action 10:53:34 INFO - [mozharness: 2017-02-03 18:53:34.356006Z] Finished clobber step (success) 10:53:34 INFO - [mozharness: 2017-02-03 18:53:34.356293Z] Running read-buildbot-config step. 10:53:34 INFO - Running pre-action listener: _resource_record_pre_action 10:53:34 INFO - Running main action method: read_buildbot_config 10:53:34 INFO - Using buildbot properties: 10:53:34 INFO - { 10:53:34 INFO - "project": "", 10:53:34 INFO - "product": "firefox", 10:53:34 INFO - "script_repo_revision": "production", 10:53:34 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 10:53:34 INFO - "repository": "", 10:53:34 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 10:53:34 INFO - "buildid": "20170203093727", 10:53:34 INFO - "pgo_build": "False", 10:53:34 INFO - "basedir": "/builds/slave/test", 10:53:34 INFO - "buildnumber": 62, 10:53:34 INFO - "slavename": "t-yosemite-r7-0079", 10:53:34 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 10:53:34 INFO - "platform": "yosemite_r7", 10:53:34 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 10:53:34 INFO - "branch": "mozilla-central", 10:53:34 INFO - "repo_path": "mozilla-central", 10:53:34 INFO - "revision": "bf15d4078c2a6db7df37ab466d28a1e075c9eb4d", 10:53:34 INFO - "stage_platform": "macosx64", 10:53:34 INFO - "builduid": "aa5e83bf318542579d67277c67d7a09c", 10:53:34 INFO - "slavebuilddir": "test" 10:53:34 INFO - } 10:53:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/PK0IxXuZTtKdOo-s_sGFZw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 10:53:34 INFO - Running post-action listener: _resource_record_post_action 10:53:34 INFO - [mozharness: 2017-02-03 18:53:34.361921Z] Finished read-buildbot-config step (success) 10:53:34 INFO - [mozharness: 2017-02-03 18:53:34.362112Z] Running download-and-extract step. 10:53:34 INFO - Running pre-action listener: _resource_record_pre_action 10:53:34 INFO - Running main action method: download_and_extract 10:53:34 INFO - mkdir: /builds/slave/test/build/tests 10:53: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')]} 10:53:34 INFO - trying https://queue.taskcluster.net/v1/task/PK0IxXuZTtKdOo-s_sGFZw/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 10:53:34 INFO - Downloading https://queue.taskcluster.net/v1/task/PK0IxXuZTtKdOo-s_sGFZw/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 10:53:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PK0IxXuZTtKdOo-s_sGFZw/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 10:53:35 INFO - Downloaded 1199 bytes. 10:53:35 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 10:53:35 INFO - Using the following test package requirements: 10:53:35 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 10:53:35 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 10:53:35 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 10:53:35 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 10:53:35 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 10:53:35 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 10:53:35 INFO - u'jsshell-mac.zip'], 10:53:35 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 10:53:35 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 10:53:35 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 10:53:35 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 10:53:35 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 10:53:35 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 10:53:35 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 10:53:35 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 10:53:35 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 10:53:35 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 10:53:35 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 10:53:35 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:53:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PK0IxXuZTtKdOo-s_sGFZw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 10:53:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PK0IxXuZTtKdOo-s_sGFZw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:53:35 INFO - Fetch https://queue.taskcluster.net/v1/task/PK0IxXuZTtKdOo-s_sGFZw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 10:53:37 INFO - Expected file size: 34850065 10:53:37 INFO - Obtained file size: 34850065 10:53:44 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 10:53:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PK0IxXuZTtKdOo-s_sGFZw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 10:53:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PK0IxXuZTtKdOo-s_sGFZw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:53:44 INFO - Fetch https://queue.taskcluster.net/v1/task/PK0IxXuZTtKdOo-s_sGFZw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 10:53:45 INFO - Expected file size: 34850065 10:53:45 INFO - Obtained file size: 34850065 10:53:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PK0IxXuZTtKdOo-s_sGFZw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 10:53:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PK0IxXuZTtKdOo-s_sGFZw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 10:53:52 INFO - Fetch https://queue.taskcluster.net/v1/task/PK0IxXuZTtKdOo-s_sGFZw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 10:53:52 INFO - Expected file size: 14403454 10:53:52 INFO - Obtained file size: 14403454 10:53: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')]} 10:53:53 INFO - trying https://queue.taskcluster.net/v1/task/PK0IxXuZTtKdOo-s_sGFZw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 10:53:53 INFO - Downloading https://queue.taskcluster.net/v1/task/PK0IxXuZTtKdOo-s_sGFZw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 10:53:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PK0IxXuZTtKdOo-s_sGFZw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 10:53:55 INFO - Downloaded 70287453 bytes. 10:53:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PK0IxXuZTtKdOo-s_sGFZw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 10:53:55 INFO - mkdir: /builds/slave/test/properties 10:53:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:53:55 INFO - Writing to file /builds/slave/test/properties/build_url 10:53:55 INFO - Contents: 10:53:55 INFO - build_url:https://queue.taskcluster.net/v1/task/PK0IxXuZTtKdOo-s_sGFZw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 10:53:56 INFO - Running post-action listener: _resource_record_post_action 10:53:56 INFO - Running post-action listener: set_extra_try_arguments 10:53:56 INFO - [mozharness: 2017-02-03 18:53:56.050800Z] Finished download-and-extract step (success) 10:53:56 INFO - [mozharness: 2017-02-03 18:53:56.050961Z] Running populate-webroot step. 10:53:56 INFO - Running pre-action listener: _resource_record_pre_action 10:53:56 INFO - Running main action method: populate_webroot 10:53:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:53:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:53:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:53:56 INFO - '--tppagecycles', 10:53:56 INFO - '7'], 10:53:56 INFO - 'tests': ['tsvgm']}}, 10:53:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:53:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:53:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:53:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:53:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:53:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:53:56 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:53:56 INFO - 'talos_options': ['--disable-e10s'], 10:53:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:53:56 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:53:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:53:56 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:53:56 INFO - 'talos_options': ['--disable-e10s'], 10:53:56 INFO - 'tests': ['damp', 'tps']}, 10:53:56 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:53:56 INFO - 'tests': ['damp', 'tps']}, 10:53:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:53:56 INFO - 'tests': ['dromaeo_dom']}, 10:53:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:53:56 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:53:56 INFO - 'tests': ['basic_compositor_video']}, 10:53:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:53:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:53:56 INFO - 'tests': ['a11yr', 10:53:56 INFO - 'ts_paint', 10:53:56 INFO - 'tpaint', 10:53:56 INFO - 'sessionrestore', 10:53:56 INFO - 'sessionrestore_no_auto_restore', 10:53:56 INFO - 'tabpaint']}, 10:53:56 INFO - 'other-e10s': {'tests': ['a11yr', 10:53:56 INFO - 'ts_paint', 10:53:56 INFO - 'tpaint', 10:53:56 INFO - 'sessionrestore', 10:53:56 INFO - 'sessionrestore_no_auto_restore', 10:53:56 INFO - 'tabpaint']}, 10:53:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:53:56 INFO - 'ts_paint', 10:53:56 INFO - 'tpaint', 10:53:56 INFO - 'sessionrestore', 10:53:56 INFO - 'sessionrestore_no_auto_restore', 10:53:56 INFO - 'tabpaint']}, 10:53:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:53:56 INFO - 'ts_paint', 10:53:56 INFO - 'tpaint', 10:53:56 INFO - 'sessionrestore', 10:53:56 INFO - 'sessionrestore_no_auto_restore', 10:53:56 INFO - 'tabpaint']}, 10:53:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:53:56 INFO - 'tests': ['a11yr', 10:53:56 INFO - 'ts_paint', 10:53:56 INFO - 'tpaint', 10:53:56 INFO - 'sessionrestore', 10:53:56 INFO - 'sessionrestore_no_auto_restore', 10:53:56 INFO - 'tabpaint']}, 10:53:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:53:56 INFO - 'tests': ['a11yr', 10:53:56 INFO - 'ts_paint', 10:53:56 INFO - 'tpaint', 10:53:56 INFO - 'sessionrestore', 10:53:56 INFO - 'sessionrestore_no_auto_restore', 10:53:56 INFO - 'tabpaint']}, 10:53:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:53:56 INFO - 'tests': ['tsvgx', 10:53:56 INFO - 'tsvgr_opacity', 10:53:56 INFO - 'tart', 10:53:56 INFO - 'tscrollx', 10:53:56 INFO - 'cart', 10:53:56 INFO - 'tsvg_static']}, 10:53:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:53:56 INFO - 'tsvgr_opacity', 10:53:56 INFO - 'tart', 10:53:56 INFO - 'tscrollx', 10:53:56 INFO - 'cart', 10:53:56 INFO - 'tsvg_static']}, 10:53:56 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:53:56 INFO - 'talos_options': ['--disable-e10s'], 10:53:56 INFO - 'tests': ['tp5o']}, 10:53:56 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:53:56 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:53:56 INFO - 'talos_options': ['--disable-e10s', 10:53:56 INFO - '--xperf_path', 10:53:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:53:56 INFO - 'tests': ['tp5n']}, 10:53:56 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:53:56 INFO - 'talos_options': ['--xperf_path', 10:53:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:53:56 INFO - 'tests': ['tp5n']}}, 10:53:56 INFO - 'talos.zip': {'path': '', 10:53:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:53:56 INFO - Running post-action listener: _resource_record_post_action 10:53:56 INFO - [mozharness: 2017-02-03 18:53:56.069149Z] Finished populate-webroot step (success) 10:53:56 INFO - [mozharness: 2017-02-03 18:53:56.069277Z] Running create-virtualenv step. 10:53:56 INFO - Running pre-action listener: _resource_record_pre_action 10:53:56 INFO - Running main action method: create_virtualenv 10:53:56 INFO - Creating virtualenv /builds/slave/test/build/venv 10:53:56 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:53:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:53:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:53:56 INFO - Using real prefix '/tools/python27' 10:53:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:53:56 INFO - Installing distribute.............................................................................................................................................................................................done. 10:53:59 INFO - Installing pip.................done. 10:53:59 INFO - Return code: 0 10:53:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:53:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:54:00 INFO - Reading from file tmpfile_stdout 10:54:00 INFO - Output received: 10:54:00 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 10:54:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:54:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:54:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:54:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d906b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d909768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8e85b23d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6e4d30>, '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 0x10d60bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d6d9be8>, '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.8JQk8pwnOO/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.CWwUEMB98p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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 10:54:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:54:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:54:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8JQk8pwnOO/Render', 10:54:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:54:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:54:00 INFO - 'HOME': '/Users/cltbld', 10:54:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:54:00 INFO - 'LOGNAME': 'cltbld', 10:54:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:00 INFO - 'MOZ_NO_REMOTE': '1', 10:54:00 INFO - 'NO_EM_RESTART': '1', 10:54:00 INFO - 'PAGER': '/bin/cat', 10:54:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:54:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:00 INFO - 'PWD': '/builds/slave/test', 10:54:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:54:00 INFO - 'SHELL': '/bin/bash', 10:54:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CWwUEMB98p/Listeners', 10:54:00 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 10:54:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:54:00 INFO - 'USER': 'cltbld', 10:54:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:54:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:54:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:00 INFO - 'XPC_FLAGS': '0x0', 10:54:00 INFO - 'XPC_SERVICE_NAME': '0', 10:54:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:54:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:00 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:54:00 INFO - Cleaning up... 10:54:00 INFO - Return code: 0 10:54:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:54:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:54:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:54:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d906b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d909768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8e85b23d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6e4d30>, '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 0x10d60bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d6d9be8>, '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.8JQk8pwnOO/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.CWwUEMB98p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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 10:54:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:54:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:54:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8JQk8pwnOO/Render', 10:54:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:54:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:54:00 INFO - 'HOME': '/Users/cltbld', 10:54:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:54:00 INFO - 'LOGNAME': 'cltbld', 10:54:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:00 INFO - 'MOZ_NO_REMOTE': '1', 10:54:00 INFO - 'NO_EM_RESTART': '1', 10:54:00 INFO - 'PAGER': '/bin/cat', 10:54:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:54:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:00 INFO - 'PWD': '/builds/slave/test', 10:54:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:54:00 INFO - 'SHELL': '/bin/bash', 10:54:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CWwUEMB98p/Listeners', 10:54:00 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 10:54:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:54:00 INFO - 'USER': 'cltbld', 10:54:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:54:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:54:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:00 INFO - 'XPC_FLAGS': '0x0', 10:54:00 INFO - 'XPC_SERVICE_NAME': '0', 10:54:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:54:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:00 INFO - Downloading/unpacking psutil>=3.1.1 10:54:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:54:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:54:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:54:04 INFO - Installing collected packages: psutil 10:54:04 INFO - Running setup.py install for psutil 10:54:04 INFO - building 'psutil._psutil_osx' extension 10:54:04 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 10:54:04 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 10:54:04 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 10:54:04 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 10:54:04 INFO - building 'psutil._psutil_posix' extension 10:54:04 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 10:54:05 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:54:05 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:54:05 INFO - ^ 10:54:05 INFO - 1 warning generated. 10:54:05 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 10:54:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:54:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:54:05 INFO - Successfully installed psutil 10:54:05 INFO - Cleaning up... 10:54:05 INFO - Return code: 0 10:54:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:54:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:54:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:54:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:05 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 0x10d906b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d909768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8e85b23d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6e4d30>, '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 0x10d60bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d6d9be8>, '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.8JQk8pwnOO/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.CWwUEMB98p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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 10:54:05 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 10:54:05 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 10:54:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8JQk8pwnOO/Render', 10:54:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:54:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:54:05 INFO - 'HOME': '/Users/cltbld', 10:54:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:54:05 INFO - 'LOGNAME': 'cltbld', 10:54:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:05 INFO - 'MOZ_NO_REMOTE': '1', 10:54:05 INFO - 'NO_EM_RESTART': '1', 10:54:05 INFO - 'PAGER': '/bin/cat', 10:54:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:54:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:05 INFO - 'PWD': '/builds/slave/test', 10:54:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:54:05 INFO - 'SHELL': '/bin/bash', 10:54:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CWwUEMB98p/Listeners', 10:54:05 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 10:54:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:54:05 INFO - 'USER': 'cltbld', 10:54:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:54:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:54:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:05 INFO - 'XPC_FLAGS': '0x0', 10:54:05 INFO - 'XPC_SERVICE_NAME': '0', 10:54:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:54:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:54:05 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 10:54:05 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 10:54:05 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 10:54:05 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 10:54:05 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 10:54:05 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 10:54:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:54:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:54:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:54:08 INFO - Installing collected packages: mozsystemmonitor 10:54:08 INFO - Running setup.py install for mozsystemmonitor 10:54:08 INFO - Successfully installed mozsystemmonitor 10:54:08 INFO - Cleaning up... 10:54:08 INFO - Return code: 0 10:54:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:54:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:54:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:54:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d906b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d909768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8e85b23d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6e4d30>, '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 0x10d60bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d6d9be8>, '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.8JQk8pwnOO/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.CWwUEMB98p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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 10:54:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:54:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:54:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8JQk8pwnOO/Render', 10:54:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:54:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:54:08 INFO - 'HOME': '/Users/cltbld', 10:54:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:54:08 INFO - 'LOGNAME': 'cltbld', 10:54:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:08 INFO - 'MOZ_NO_REMOTE': '1', 10:54:08 INFO - 'NO_EM_RESTART': '1', 10:54:08 INFO - 'PAGER': '/bin/cat', 10:54:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:54:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:08 INFO - 'PWD': '/builds/slave/test', 10:54:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:54:08 INFO - 'SHELL': '/bin/bash', 10:54:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CWwUEMB98p/Listeners', 10:54:08 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 10:54:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:54:08 INFO - 'USER': 'cltbld', 10:54:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:54:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:54:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:08 INFO - 'XPC_FLAGS': '0x0', 10:54:08 INFO - 'XPC_SERVICE_NAME': '0', 10:54:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:54:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:08 INFO - Downloading/unpacking jsonschema==2.5.1 10:54:08 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 10:54:08 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 10:54:08 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 10:54:08 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 10:54:08 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 10:54:08 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 10:54:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:54:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:54:11 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 10:54:11 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 10:54:11 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 10:54:11 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 10:54:11 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 10:54:11 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 10:54:11 INFO - Downloading functools32-3.2.3-2.tar.gz 10:54:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:54:11 INFO - warning: no files found matching '*.txt' 10:54:11 INFO - no previously-included directories found matching 'build' 10:54:11 INFO - no previously-included directories found matching 'dist' 10:54:11 INFO - no previously-included directories found matching '.git*' 10:54:11 INFO - Installing collected packages: jsonschema, functools32 10:54:11 INFO - Running setup.py install for functools32 10:54:12 INFO - warning: no files found matching '*.txt' 10:54:12 INFO - no previously-included directories found matching 'build' 10:54:12 INFO - no previously-included directories found matching 'dist' 10:54:12 INFO - no previously-included directories found matching '.git*' 10:54:12 INFO - Successfully installed jsonschema functools32 10:54:12 INFO - Cleaning up... 10:54:12 INFO - Return code: 0 10:54:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:54:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:54:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:54:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d906b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d909768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8e85b23d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6e4d30>, '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 0x10d60bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d6d9be8>, '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.8JQk8pwnOO/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.CWwUEMB98p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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 10:54:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:54:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:54:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8JQk8pwnOO/Render', 10:54:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:54:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:54:12 INFO - 'HOME': '/Users/cltbld', 10:54:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:54:12 INFO - 'LOGNAME': 'cltbld', 10:54:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:12 INFO - 'MOZ_NO_REMOTE': '1', 10:54:12 INFO - 'NO_EM_RESTART': '1', 10:54:12 INFO - 'PAGER': '/bin/cat', 10:54:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:54:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:12 INFO - 'PWD': '/builds/slave/test', 10:54:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:54:12 INFO - 'SHELL': '/bin/bash', 10:54:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CWwUEMB98p/Listeners', 10:54:12 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 10:54:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:54:12 INFO - 'USER': 'cltbld', 10:54:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:54:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:54:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:12 INFO - 'XPC_FLAGS': '0x0', 10:54:12 INFO - 'XPC_SERVICE_NAME': '0', 10:54:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:54:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:54:12 INFO - Cleaning up... 10:54:12 INFO - Return code: 0 10:54:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:54:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:54:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:54:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d906b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d909768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8e85b23d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6e4d30>, '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 0x10d60bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d6d9be8>, '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.8JQk8pwnOO/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.CWwUEMB98p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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 10:54:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:54:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:54:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8JQk8pwnOO/Render', 10:54:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:54:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:54:12 INFO - 'HOME': '/Users/cltbld', 10:54:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:54:12 INFO - 'LOGNAME': 'cltbld', 10:54:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:12 INFO - 'MOZ_NO_REMOTE': '1', 10:54:12 INFO - 'NO_EM_RESTART': '1', 10:54:12 INFO - 'PAGER': '/bin/cat', 10:54:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:54:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:12 INFO - 'PWD': '/builds/slave/test', 10:54:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:54:12 INFO - 'SHELL': '/bin/bash', 10:54:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CWwUEMB98p/Listeners', 10:54:12 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 10:54:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:54:12 INFO - 'USER': 'cltbld', 10:54:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:54:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:54:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:12 INFO - 'XPC_FLAGS': '0x0', 10:54:12 INFO - 'XPC_SERVICE_NAME': '0', 10:54:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:54:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:12 INFO - Downloading/unpacking blobuploader==1.2.4 10:54:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:15 INFO - Downloading blobuploader-1.2.4.tar.gz 10:54:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:54:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:54:15 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 10:54:15 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 10:54:15 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 10:54:15 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 10:54:15 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 10:54:15 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 10:54:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:54:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:54:16 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 10:54:16 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 10:54:16 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 10:54:16 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 10:54:16 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 10:54:16 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 10:54:16 INFO - Downloading docopt-0.6.1.tar.gz 10:54:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:54:16 INFO - Installing collected packages: blobuploader, requests, docopt 10:54:16 INFO - Running setup.py install for blobuploader 10:54:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:54:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:54:16 INFO - Running setup.py install for requests 10:54:17 INFO - Running setup.py install for docopt 10:54:17 INFO - Successfully installed blobuploader requests docopt 10:54:17 INFO - Cleaning up... 10:54:17 INFO - Return code: 0 10:54:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:54: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')]} 10:54:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54: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')]} 10:54:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:17 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 0x10d906b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d909768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8e85b23d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6e4d30>, '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 0x10d60bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d6d9be8>, '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.8JQk8pwnOO/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.CWwUEMB98p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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 10:54:17 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 10:54:17 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 10:54:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8JQk8pwnOO/Render', 10:54:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:54:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:54:17 INFO - 'HOME': '/Users/cltbld', 10:54:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:54:17 INFO - 'LOGNAME': 'cltbld', 10:54:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:17 INFO - 'MOZ_NO_REMOTE': '1', 10:54:17 INFO - 'NO_EM_RESTART': '1', 10:54:17 INFO - 'PAGER': '/bin/cat', 10:54:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:54:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:17 INFO - 'PWD': '/builds/slave/test', 10:54:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:54:17 INFO - 'SHELL': '/bin/bash', 10:54:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CWwUEMB98p/Listeners', 10:54:17 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 10:54:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:54:17 INFO - 'USER': 'cltbld', 10:54:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:54:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:54:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:17 INFO - 'XPC_FLAGS': '0x0', 10:54:17 INFO - 'XPC_SERVICE_NAME': '0', 10:54:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:54:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:54:17 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-VV6MiK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:54:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:54:17 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-xjldUe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:54:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:54:17 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-2oOzSG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:54:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:54:18 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-4qhNkH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:54:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:54:18 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-TuDJTt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:54:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:54:18 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-xF20Dq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:54:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:54:18 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-nYEdeI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:54:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:54:18 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-doZUmp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:54:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:54:18 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-0li9DU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:54:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:54:18 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-7s75mO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:54:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:54:18 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-UP_RZm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:54:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:54:18 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-Xf31VF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:54:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:54:19 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-DbjWMG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:54:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:54:19 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-nuvGVu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:54:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:54:19 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-9I9vMT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:54:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:54:19 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-AyfL3q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:54:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:54:19 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-houPy2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:54:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:54:19 INFO - Running setup.py install for manifestparser 10:54:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:54:19 INFO - Running setup.py install for mozcrash 10:54:19 INFO - Running setup.py install for mozdebug 10:54:19 INFO - Running setup.py install for mozdevice 10:54:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:54:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:54:20 INFO - Running setup.py install for mozfile 10:54:20 INFO - Running setup.py install for mozhttpd 10:54:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:54:20 INFO - Running setup.py install for mozinfo 10:54:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:54:20 INFO - Running setup.py install for mozInstall 10:54:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:54:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:54:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:54:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:54:20 INFO - Running setup.py install for mozleak 10:54:20 INFO - Running setup.py install for mozlog 10:54:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:54:21 INFO - Running setup.py install for moznetwork 10:54:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:54:21 INFO - Running setup.py install for mozprocess 10:54:21 INFO - Running setup.py install for mozprofile 10:54:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:54:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:54:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:54:21 INFO - Running setup.py install for mozrunner 10:54:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:54:21 INFO - Running setup.py install for mozscreenshot 10:54:21 INFO - Running setup.py install for moztest 10:54:21 INFO - Running setup.py install for mozversion 10:54:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:54:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:54:22 INFO - Cleaning up... 10:54:22 INFO - Return code: 0 10:54:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:54:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:54:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:54:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d906b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d909768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8e85b23d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6e4d30>, '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 0x10d60bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d6d9be8>, '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.8JQk8pwnOO/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.CWwUEMB98p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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 10:54:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:54:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:54:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8JQk8pwnOO/Render', 10:54:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:54:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:54:23 INFO - 'HOME': '/Users/cltbld', 10:54:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:54:23 INFO - 'LOGNAME': 'cltbld', 10:54:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:23 INFO - 'MOZ_NO_REMOTE': '1', 10:54:23 INFO - 'NO_EM_RESTART': '1', 10:54:23 INFO - 'PAGER': '/bin/cat', 10:54:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:54:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:23 INFO - 'PWD': '/builds/slave/test', 10:54:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:54:23 INFO - 'SHELL': '/bin/bash', 10:54:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CWwUEMB98p/Listeners', 10:54:23 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 10:54:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:54:23 INFO - 'USER': 'cltbld', 10:54:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:54:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:54:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:23 INFO - 'XPC_FLAGS': '0x0', 10:54:23 INFO - 'XPC_SERVICE_NAME': '0', 10:54:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:54:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:54:23 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-363Tiw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:54:23 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)) 10:54:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:54:23 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-azK1ZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:54:23 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)) 10:54:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:54:23 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-yIPbk9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:54:23 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)) 10:54:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:54:23 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-AcHWA4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:54:23 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)) 10:54:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:54:23 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-zjYX9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:54:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:54:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:54:24 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-gTTAQZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:54:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:54:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:54:24 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-jEDN3q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:54:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:54:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:54:24 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-KFdOK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:54:24 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)) 10:54:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:54:24 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-2XVnN6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:54:24 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)) 10:54:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:54:24 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-nQajP0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:54:24 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)) 10:54:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:54:24 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-BOXfxE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:54:24 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)) 10:54:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:54:24 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-V0nXGU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:54:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 10:54:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:54:24 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-JXFA88-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:54:24 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)) 10:54:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:54:24 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-BJXzc1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:54:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:54:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:54:25 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-HhiodZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:54:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:54:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:54:25 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-g_lbJM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:54:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:54:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:54:25 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-eFYTL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:54:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:54:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:54:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:54:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:54:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:54:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:54:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:54: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 10:54: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 10:54: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 10:54: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 10:54: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 10:54: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 10:54:28 INFO - Downloading blessings-1.6.tar.gz 10:54:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:54:28 INFO - Installing collected packages: blessings 10:54:28 INFO - Running setup.py install for blessings 10:54:28 INFO - Successfully installed blessings 10:54:28 INFO - Cleaning up... 10:54:28 INFO - Return code: 0 10:54:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:54:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:54:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:54:29 INFO - Reading from file tmpfile_stdout 10:54:29 INFO - Current package versions: 10:54:29 INFO - blessings == 1.6 10:54:29 INFO - blobuploader == 1.2.4 10:54:29 INFO - docopt == 0.6.1 10:54:29 INFO - functools32 == 3.2.3-2 10:54:29 INFO - jsonschema == 2.5.1 10:54:29 INFO - manifestparser == 1.1 10:54:29 INFO - mozInstall == 1.12 10:54:29 INFO - mozcrash == 1.0 10:54:29 INFO - mozdebug == 0.1 10:54:29 INFO - mozdevice == 0.49 10:54:29 INFO - mozfile == 1.2 10:54:29 INFO - mozhttpd == 0.7 10:54:29 INFO - mozinfo == 0.9 10:54:29 INFO - mozleak == 0.1 10:54:29 INFO - mozlog == 3.4 10:54:29 INFO - moznetwork == 0.27 10:54:29 INFO - mozprocess == 0.24 10:54:29 INFO - mozprofile == 0.28 10:54:29 INFO - mozrunner == 6.13 10:54:29 INFO - mozscreenshot == 0.1 10:54:29 INFO - mozsystemmonitor == 0.3 10:54:29 INFO - moztest == 0.8 10:54:29 INFO - mozversion == 1.4 10:54:29 INFO - psutil == 3.1.1 10:54:29 INFO - requests == 1.2.3 10:54:29 INFO - wsgiref == 0.1.2 10:54:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:54:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:54:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:54:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d906b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d909768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8e85b23d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6e4d30>, '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 0x10d60bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d6d9be8>, '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.8JQk8pwnOO/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.CWwUEMB98p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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 10:54:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:54:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:54:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8JQk8pwnOO/Render', 10:54:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:54:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:54:29 INFO - 'HOME': '/Users/cltbld', 10:54:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:54:29 INFO - 'LOGNAME': 'cltbld', 10:54:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:29 INFO - 'MOZ_NO_REMOTE': '1', 10:54:29 INFO - 'NO_EM_RESTART': '1', 10:54:29 INFO - 'PAGER': '/bin/cat', 10:54:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:54:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:29 INFO - 'PWD': '/builds/slave/test', 10:54:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:54:29 INFO - 'SHELL': '/bin/bash', 10:54:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CWwUEMB98p/Listeners', 10:54:29 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 10:54:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:54:29 INFO - 'USER': 'cltbld', 10:54:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:54:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:54:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:29 INFO - 'XPC_FLAGS': '0x0', 10:54:29 INFO - 'XPC_SERVICE_NAME': '0', 10:54:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:54:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:54:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:54:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:54:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:54:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:54:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:54:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:54:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:54:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:54:29 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:54:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:54:29 INFO - Cleaning up... 10:54:29 INFO - Return code: 0 10:54:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:54:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:54:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:54:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d906b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d909768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd8e85b23d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6e4d30>, '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 0x10d60bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d6d9be8>, '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.8JQk8pwnOO/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.CWwUEMB98p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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 10:54:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:54:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:54:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8JQk8pwnOO/Render', 10:54:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:54:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:54:29 INFO - 'HOME': '/Users/cltbld', 10:54:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:54:29 INFO - 'LOGNAME': 'cltbld', 10:54:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:29 INFO - 'MOZ_NO_REMOTE': '1', 10:54:29 INFO - 'NO_EM_RESTART': '1', 10:54:29 INFO - 'PAGER': '/bin/cat', 10:54:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:54:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:29 INFO - 'PWD': '/builds/slave/test', 10:54:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:54:29 INFO - 'SHELL': '/bin/bash', 10:54:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CWwUEMB98p/Listeners', 10:54:29 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 10:54:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:54:29 INFO - 'USER': 'cltbld', 10:54:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:54:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:54:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:29 INFO - 'XPC_FLAGS': '0x0', 10:54:29 INFO - 'XPC_SERVICE_NAME': '0', 10:54:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:54:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:54:29 INFO - Cleaning up... 10:54:29 INFO - Return code: 0 10:54:29 INFO - Running post-action listener: _resource_record_post_action 10:54:29 INFO - Running post-action listener: _start_resource_monitoring 10:54:29 INFO - Starting resource monitoring. 10:54:29 INFO - [mozharness: 2017-02-03 18:54:29.698365Z] Finished create-virtualenv step (success) 10:54:29 INFO - [mozharness: 2017-02-03 18:54:29.699277Z] Running install step. 10:54:29 INFO - Running pre-action listener: _resource_record_pre_action 10:54:29 INFO - Running main action method: install 10:54:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:54:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:54:29 INFO - Reading from file tmpfile_stdout 10:54:29 INFO - Detecting whether we're running mozinstall >=1.0... 10:54:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:54:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:54:30 INFO - Reading from file tmpfile_stdout 10:54:30 INFO - Output received: 10:54:30 INFO - Usage: mozinstall [options] installer 10:54:30 INFO - Options: 10:54:30 INFO - -h, --help show this help message and exit 10:54:30 INFO - -d DEST, --destination=DEST 10:54:30 INFO - Directory to install application into. [default: 10:54:30 INFO - "/builds/slave/test"] 10:54:30 INFO - --app=APP Application being installed. [default: firefox] 10:54:30 INFO - mkdir: /builds/slave/test/build/application 10:54:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:54:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 10:54:52 INFO - Reading from file tmpfile_stdout 10:54:52 INFO - Output received: 10:54:52 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:54:52 INFO - Running post-action listener: _resource_record_post_action 10:54:52 INFO - [mozharness: 2017-02-03 18:54:52.204767Z] Finished install step (success) 10:54:52 INFO - [mozharness: 2017-02-03 18:54:52.204910Z] Running run-tests step. 10:54:52 INFO - Running pre-action listener: _resource_record_pre_action 10:54:52 INFO - Running main action method: run_tests 10:54:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:54:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:54:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:54:52 INFO - 2017-02-03 10:54:52.219 screenresolution[1626:7213] starting screenresolution argv=screenresolution get 10:54:52 INFO - 2017-02-03 10:54:52.222 screenresolution[1626:7213] Display 0: 1600x1200x32@60 10:54:52 INFO - 2017-02-03 10:54:52.228 screenresolution[1627:7216] starting screenresolution argv=screenresolution list 10:54:52 INFO - Available Modes on Display 0 10:54:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:54:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:54:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:54:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:54:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:54:52 INFO - Intel Iris: 10:54:52 INFO - Chipset Model: Intel Iris 10:54:52 INFO - Type: GPU 10:54:52 INFO - Bus: Built-In 10:54:52 INFO - VRAM (Dynamic, Max): 1536 MB 10:54:52 INFO - Vendor: Intel (0x8086) 10:54:52 INFO - Device ID: 0x0a2e 10:54:52 INFO - Revision ID: 0x0009 10:54:52 INFO - Displays: 10:54:52 INFO - Display: 10:54:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:54:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:54:52 INFO - Display Serial Number: 1600x1200 60 10:54:52 INFO - Main Display: Yes 10:54:52 INFO - Mirror: Off 10:54:52 INFO - Online: Yes 10:54:52 INFO - Rotation: Supported 10:54:52 INFO - Return code: 0 10:54:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:54:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:54:52 INFO - Python 2.7.3 10:54:52 INFO - Return code: 0 10:54:52 INFO - grabbing minidump binary from tooltool 10:54:52 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')]} 10:54:52 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 0x10d6e4d30>, '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 0x10d60bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d6d9be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:54:52 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 10:54:52 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 10:54:52 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 10:54:52 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:54:52 INFO - Return code: 0 10:54:52 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:54:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:54:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:54:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:54:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:54:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PK0IxXuZTtKdOo-s_sGFZw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0079', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:54:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PK0IxXuZTtKdOo-s_sGFZw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0079 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:54:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8JQk8pwnOO/Render', 10:54:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:54:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:54:52 INFO - 'HOME': '/Users/cltbld', 10:54:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:54:52 INFO - 'LOGNAME': 'cltbld', 10:54:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:54:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:54:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:52 INFO - 'MOZ_NO_REMOTE': '1', 10:54:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:54:52 INFO - 'NO_EM_RESTART': '1', 10:54:52 INFO - 'PAGER': '/bin/cat', 10:54:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:54:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:52 INFO - 'PWD': '/builds/slave/test', 10:54:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:54:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:54:52 INFO - 'SHELL': '/bin/bash', 10:54:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CWwUEMB98p/Listeners', 10:54:52 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 10:54:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:54:52 INFO - 'USER': 'cltbld', 10:54:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:54:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:54:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:52 INFO - 'XPC_FLAGS': '0x0', 10:54:52 INFO - 'XPC_SERVICE_NAME': '0', 10:54:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:54:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PK0IxXuZTtKdOo-s_sGFZw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0079', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:54:52 INFO - mozversion application_buildid: 20170203093727 10:54:52 INFO - mozversion application_changeset: bf15d4078c2a6db7df37ab466d28a1e075c9eb4d 10:54:52 INFO - mozversion application_display_name: Nightly 10:54:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:54:52 INFO - mozversion application_name: Firefox 10:54:52 INFO - mozversion application_remotingname: firefox 10:54:52 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:54:52 INFO - mozversion application_vendor: Mozilla 10:54:52 INFO - mozversion application_version: 54.0a1 10:54:52 INFO - mozversion platform_buildid: 20170203093727 10:54:52 INFO - mozversion platform_changeset: bf15d4078c2a6db7df37ab466d28a1e075c9eb4d 10:54:52 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:54:52 INFO - mozversion platform_version: 54.0a1 10:54:52 INFO - using testdate: 1486148092 10:54:52 INFO - actual date: 1486148092 10:54:52 INFO - starting webserver on 'localhost:49243' 10:54:52 INFO - SUITE-START | Running 2 tests 10:54:52 INFO - TEST-START | dromaeo_css 10:54:52 INFO - operating with platform_type : mac_ 10:54:52 INFO - Initialising browser for dromaeo_css test... 10:54:52 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/tmpAGOBKa/profile http://localhost:49243/getInfo.html) 10:54:54 INFO - PROCESS | 1637 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 10:54:55 INFO - PROCESS | 1637 | __metrics Screen width/height:1600/1200 10:54:55 INFO - PROCESS | 1637 | colorDepth:24 10:54:55 INFO - PROCESS | 1637 | Browser inner width/height: 1024/689 10:54:55 INFO - PROCESS | 1637 | __metrics 10:54:55 INFO - PROCESS | 1637 | 1486148095265 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 10:54:55 INFO - PROCESS | 1637 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:54:55 INFO - PROCESS | 1637 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:54:56 INFO - TEST-INFO | 1637: exit 0 10:54:56 INFO - Browser initialized. 10:54:56 INFO - Running cycle 1/1 for dromaeo_css test... 10:54:56 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/tmpAGOBKa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:55:08 INFO - PROCESS | 1639 | RSS: Main: 236924928 10:55:08 INFO - PROCESS | 1639 | 10:58:11 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 10:58:13 INFO - PROCESS | 1639 | RSS: Main: 418217984 10:58:13 INFO - PROCESS | 1639 | 10:59:58 INFO - PROCESS | 1639 | ************************* 10:59:58 INFO - PROCESS | 1639 | A coding exception was thrown and uncaught in a Task. 10:59:58 INFO - PROCESS | 1639 | 10:59:58 ERROR - PROCESS | 1639 | Full message: TypeError: NetworkError when attempting to fetch resource. 10:59:58 INFO - PROCESS | 1639 | Full stack: 10:59:58 INFO - PROCESS | 1639 | ************************* 11:01:17 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 11:01:17 INFO - PROCESS | 1639 | RSS: Main: 372256768 11:01:17 INFO - PROCESS | 1639 | 11:04:19 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 11:04:20 INFO - PROCESS | 1639 | RSS: Main: 363892736 11:04:20 INFO - PROCESS | 1639 | 11:07:22 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 11:07:23 INFO - PROCESS | 1639 | RSS: Main: 343695360 11:07:23 INFO - PROCESS | 1639 | 11:10:26 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 11:10:27 INFO - PROCESS | 1639 | RSS: Main: 331235328 11:10:27 INFO - PROCESS | 1639 | 11:13:30 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 11:13:31 INFO - PROCESS | 1639 | RSS: Main: 611672064 11:13:31 INFO - PROCESS | 1639 | 11:13:31 INFO - PROCESS | 1639 | __start_tp_report 11:13:31 INFO - PROCESS | 1639 | _x_x_mozilla_page_load 11:13:31 INFO - PROCESS | 1639 | _x_x_mozilla_page_load_details 11:13:31 INFO - PROCESS | 1639 | |i|pagename|runs| 11:13:31 INFO - PROCESS | 1639 | |0;dojo.html;2829.9575506367396;3304.9919774468794;3311.9172020699493;3315.4032274190645;3377.679120483553;5245.793467502477;5534.640248383862;5613.18608801724;5694.857628559283;5763.020286551291;4514.706544074641;4964.280179373988;5383.327084114486;5625.987322281988;5664.518515926141;5068.49315068493;5124.538791508763;5156.92264616031;5164.406093299281;5220.817271395502;4852.708837469745;5053.469385714502;5255.894882102356;5256.8685782855355;5317.6809391436445;5082.034413461467;5103.56619687327;5111.2333150027425;5122.641415100945;5218.373795144588;5185.948140518584;5235.240890070956;5251.291075704769;5306.92039619406;5313.548348390392;5141.100307446182;5180.922286165711;5181.896362072775;5204.609654275944;5221.843344699665;5521.254630624854;5545.611807173499;5700.828975130711;5707.0298049331295;5735.139729040636;6115;6147.2008638877105;6194.5354098442795;6206.441420272197;6258.4680302174365;6178.289496707891;6274.403931626533;6281.403266689657;6287.402696743802;6293.559450838443;5758.078707406795;5827.067669172912;5828.65028098307;5840.269966254218;5869.7652093916195;6189.412005859436;6206;6243.531735119794;6245.250569931637;6245.656488893154;5114.616403769732;6019.909701354483;6022.668753218615;6031.8793624127275;6069.908951365733;6178.7219575119225;6179.969100154561;6186.597871138361;6191.81424557264;6214.161088253119;5971.731272092767;6008.459238668541;6015.819525414157;6053.364396738367;6136.8772624547255;6165.907511387333;6188.81433556994;6189.473894718909;6281.654509002049;6291.056341548804;4940.011997600423;4940.802367905244;4953.777080031407;4955.281484184773;4978.77595508203;3858.2862170498547;4460.710053846489;4471.865844024619;4486.6186374157905;4511.751853648016;5587.44125587438;5645.576581756302;5672.319321681424;5684.289463817023;5702.315722113373;6226.688665566794;6278.717457714414;6283.214598175228;6284.591501552384;6317.4630156437215;5720.685362305113;5722.341930677942;5732.34078081026;5741.799037033684;5758.424157584208;5030.522100400529;5201.271821944931;5215.243789650555;5274;5421.484958928895;6209.379062093754;6250.249970003629;6252.812415627538;6252.937470625236;6253.280872699698;6100.054491553817;6102.398363691488;6136.2636483622255;6202.4417802398;6222.62664240147;6218.129461875251;6223.222097237845;6232;6273.52948528853;6285.748570057147;6187.81436556904;6190.350013248724;6208.192934918432;6213.875722485615;6219.346968568235;5929.52563794904;6061;6085.391460853879;6193.194884665145;6194.0708893666315;6096.116063170904;6104.246950856165;6124.54065945047;6125.509959203342;6139.2325959255095;6068.241469816273;6092.421219984094;6094;6106.267247930276;6108.08378743192;4665.976670116627;5584.301962254718;5610.18652295423;5914.112883067574;5941.881162376815;5996.190514280516;6012.789552365646;6053.848653783691;6109.84725381869;6127.938720612737;5942.762289508371;5955.315138758925;5958.404159584007;5962.582619216613;5982.341942386247 11:13:31 INFO - PROCESS | 1639 | |1;ext.html;435.2383329173946;444.29357321858237;481.41267653462785;494.3746161106199;495.6158976792985;39256;41523;41817.74546763594;41857.7907110464;43511.129777404436;41645.16709665805;41878.16243675125;41958.160836783245;42030;42066;8074.71738489153;8261.669533218694;9231.538423078837;9435.528223588793;9454.196393306578;11104.222704410655;11321.660350189466;11342.773144537105;11350.09199264061;11473.426328683574;9648.469334186617;11313.886861131406;11344.319340839535;11361;11367.545298188104;8095;8303.750887473325;11130.777384452347;11227;11304.547818087267;11053.889461105447;11148.665540033811;11151.38667373294;11185.66443006711;11207.887921120766;39562.0109497262;39929.60070399288;39932.80033599814;39986.20027599432;40080.39879401811;3715.535558055243;3845.807709614536;3971.384435412516;3982.6415622594104;3986.521617405901;30025.798968041254;30430.84784576063;30443.23891902698;30514.084577462712;30576.694233057606;3084.36770462057;3143.9214019649694;3173.730232930204;3280.2619410632656;3289.605247370307;426942;427041;427473;428191.99999999686;440117;49480.268190613155;50770;58935.41064589385;59346.40653593409;59385.70307148523;52856.62145203475;66129;67260;67302.66348668226;67474.66262668655;15260.46588369424;15307.311170997333;15518.301676424588;15518.612034699223;15574.766378504331;11920.582779602672;12004.879951200552;12008.579699710468;12022.098342624338;12048.457819397972;15586.844131558766;15665.216739162996;15696.76454853178;15701.764473532907;15858.762118568231;6688.29772873851;6717.832054198684;6731.014350766535;6752.3922846944015;6765;830.4021104804531;846.229930763015;881.6297155194834;883.4346018548134;887.272436601993;27559.586606200923;28027.439451210863;29080.563791543143;29711.40577188444;29831;1033.4316126130598;1047.1518070363031;1071.689210129054;1088.5917780832187;1203.5907791350808;15161.848381516043;15343.00270482415;15389.923050384676;15547.636065557364;15730.606734831492;585635;589739;589996;590606;591508;58046.7097664509;58093.41906580965;58110;58142;58146.7092664534;1386.244496749274;1416.0370947755625;1437.8274607047222;1443.6246575890134;1450.2966061460183;28196.43607127887;28921.85539072291;28983.85508072446;29849.806007759445;30275.394492110474;48573.757131215534;50381;50446.73883152804;50483.74758126186;50522.989540208255;500701;501400;502974;503586;504921;32336.868209612552;32980.17549561184;33089.834550827094;37927.620723793516;38211.23577528489;43602.78198608987;45568;45881;47193.76403117963;47478.81302967454;37737.245255094196;37998.77010454142;38133.61866381301;38906.6109338903;39397.80301098591;37470.812645936596;38003.61996380001;38241.04397390087;39016.80491597524;39761.80119099386;29645.5553166707;36229.63770362368;36521.269574608894;36627.45058824173;37116.81441592775;32314.676853231165;33301.50047749237;33535.52172534122;33706.494402584474;33762.987110386726;23098;24736.134235301677;24764.752352476244;24936.875315623307;25008.999640014925 11:13:31 INFO - PROCESS | 1639 | |2;jquery.html;400.09777950721156;401.3017349811328;404.3994667918141;414.2688155405709;432.3083067092652;13963.720725585483;19679;20850.99999999998;20901.686474702892;20947.16211351548;20670.586588268226;20772.792272077273;21114.683279750818;21167.259145929896;21441.46396340092;5841.357450680422;6188.5358598105095;6198.946179149533;6199.69001549923;6203.193584833965;5286.444923283038;5469.316335458067;6050.515958723314;6102.084687296919;6192.628442293454;6086.813071451069;6095.085737139442;6101.481374083208;6110.052941794007;6118.510519158456;5829.504492118175;6026.758929642809;6079.179310793031;6087.0869369594475;6099.725512351911;5345.518903298683;5364.517193452569;5373.6775793452125;5375.274337964363;5379.085555455582;26443.73556264432;26679;26680.73319266802;26881.46237075267;26983.78572964221;2680.624712540246;2725.645666063399;2744.862756862149;2745.890164393422;2788.3586775041854;15275;15833.050016999017;16016.919915400465;16167.191640417932;16818.243179056848;1797.1373740604583;1820.9635807283912;1844.124041080476;1870.5510677437453;1892.3376818113688;124427.13359299618;125294.37352813178;131162.34418827845;132312.676873231;135269;11181.161412893904;11746.765064698659;11782.587609433629;11796.88203117975;11969.281843089442;12641.87358126407;14039.017268791291;15344.462943796914;15361.308741106677;15400.075995440086;6683.899741503881;7872.72445464406;8559.786005349792;8706;8716.477011379211;7212.386947109554;8512.063672995966;8522.573871306535;8574.699885503978;8625.654973800978;6783.050372947791;7224.313690199423;7333.260037380974;7366.668499917517;7436.9850275729395;1729.8529624981766;1920.932767353136;1975.8616896817373;1983.6231116087897;1987.4137129546818;1014.2899970020867;1015.1067060986285;1023.3552861697083;1042.8487869258915;1075.499892549968;17504.474865754048;19741.605167896563;20494.79505204929;20894.895525522577;21129;1037.7768779712246;1039.5841663334727;1043.2488608202082;1068.8183008888507;1076.34343050739;10726.73183170427;11066.28069175501;11073.778524429466;11122.944385278022;11141.777164456666;712305;721317;723273;723419;742219;107545;107722.92277077286;130637;131884.34057829648;136377;908.3414524469706;1011.701548043329;1027.0499787696351;1027.732789474742;1029.2280789407944;17801.554961126076;17928.92426454417;18246.270149194414;18452.327763381247;18516.444506664822;49502;50682.49317506778;50913.49086509088;50995.72510687114;52262;72023.27976720166;73374.63312683403;73476.26523734695;73499;73933;6176.66028368444;6320.525960553069;6326.2092238470195;6463.224413070461;6596.835079122869;12425.440855161358;12661.303628300531;13077.607671769862;13087;13209.603711888658;10121.544530495998;10283.228757843042;10892.673219803419;10903.073238774792;11047.116230701364;10939.726506837393;10969.067629251604;11039.116870650489;11235;11238.494267757807;10476.895231047896;10920.617778377718;11274.267172633752;11440.713982150513;11863.525458981889;7326.780196594111;8332.375071869512;8473.95763021181;8577.228049475578;8771.605277762388;5690.829275121753;6067.362926892612;10918.50866710984;11443.885561144281;11674.591389301333 11:13:31 INFO - PROCESS | 1639 | |3;mootools.html;1400.6428360768004;1417.4471955937186;1436.0952599862078;1440.9207493587862;1445.6891768269822;8288.751337459878;8586.398952073358;8610.268127209194;8728.650853965833;8747.08155643657;8256.545889976049;8398.706045288416;8576.914230857705;8633.438826476275;8647.264982476498;2261.434641339661;2290.5533420982915;2298.1726578431753;2298.712660917385;2300.64340027296;2009.457446489447;2268.092762894847;2317.8145748340175;2324.779145981129;2325.093213646679;2029.147757941668;2060.8969551522437;2062.5153089024066;2063.5967542071385;2262.3891549281684;2286.6570014497793;2295.6097463431256;2301.9424514387106;2316.420894776306;2317.6291793313158;2252.2905284835388;2317.571249318881;2344.9882750586307;2352.2590384028977;2354.5644055849552;8685.652573897036;8753.343499237582;8762.86855697165;8763.211310981978;8771.342149338825;4777.402824646919;5154.948450515484;5208.5572726318305;5316.973415132899;5328.573714102862;3323.6842499962463;3481.651834816523;3504.9649503505148;3550.91122721934;3571.821408929543;1177.164213408481;1215.7143071378218;1223.9571614993522;1270.761008017185;1271.8219449277108;11092.500837462252;11185.384803835786;11241.325520468798;11250.437478126061;11260.099192064616;4286.464191976003;4454.821807127743;4541.931871021938;4560.087982403533;4592.954070459253;8813.42712723671;8817.515036672916;8824.558772061371;8833.425827321204;8852.822943541094;5122.436531981479;5166.844994650167;5181.766820493087;5183.429822719498;5195.064888320138;4669.813207471731;4752.263399173134;4778.180768867194;4798.2082956311815;4848.248521479177;3320.887502686627;3402.8808991685173;3601.081724160322;3614.4578313253223;3644.489771432002;1104.5857803323754;1110.4281295133012;1112.2047735868894;1122.5341483284508;1128.537299707116;742.8922806193071;743.6579173580105;766.8811334243201;771.8803585444265;800.4156965415164;5391.110466772939;5489.505944465017;5557.249771280825;5573;5626.690532020778;537.1432565058725;557.2143277978032;573.9827805165852;586.8708884045503;587.1427715535366;3615.313090512794;3643.744937854378;3708.9072773180346;3724.7392682512505;3756.9436458453147;10068.748281293027;10458.738531536772;10473.266871318934;10485.68542943713;10494.317869338469;10099.64651237218;10248.692539223835;10273.332233404804;10400.27198096126;10419.114375278186;7804.68781248755;7861.52830830152;7982.880256796153;8028.237317454832;8064.999999999883;5327.520523152934;5425.972870135782;5516.310461192351;5518.006758783297;5758.2514273144225;8123.6750529978135;9285.117913798178;9300.534973251446;9422.62309507612;9545;8399.916000840158;9454.858177127211;9741.220702343937;9818.509074546388;9841.950790246003;6712.6979285931275;6895.172579290517;6901.378875901193;6901.482388820758;6919.238883722887;7963.482373645695;7989.520628762293;8019.238172373615;8114.148014458633;8159.877601836096;5751.798687045934;6484.773032943825;7254.818629534304;7313.195548489555;7528.983452947567;7185.53294035886;7232.168300645493;7247.601381924045;7260.600666963368;7279.4540409470565;6336.4614007808;6420.967895160495;6479.773207937888;6487.156669632917;6496.870062598627;4916.680415772963;4948.950510494993;4966.279889416087;5064.442911279682;5223.4515375884985;5017.448080711192;5080.593552515864;5094.592432605308;5142.614303927146;5290.365156181283 11:13:31 INFO - PROCESS | 1639 | |4;prototype.html;358.25661751864885;358.8959201831469;371.1130398347948;375.4799602550467;376.7438142063396;5164.354455693038;5226.921596176051;5392.541633961113;5422.810201642943;5504.972475137623;4834.975825120879;5211.86970325742;5250.501202385777;5251.894962100756;5344.91982620261;3645.270945810835;3874.6900247980166;4057.1479989202157;4084.7140700151003;4089.8159582818694;3491.685748282654;3581.71346292296;3621.619729928359;4093.874184599244;4124.876253712393;3475.9224640361444;3986.8604598839047;4061.3704875744306;4069.3895915612597;4071.5114186297687;3535.805530695811;3943.033956680603;4013.538443079054;4030.9596904030877;4040.838366465338;3498.041096985696;3537.451694987281;3539.3629146753574;3541.4687796830426;3556.715462762973;4246.596573325529;4532.736429770593;5265.709901074223;5277.445868183824;5373.086575282211;4518.81924723014;4520.819167233307;4527.660425468071;4549.954500454986;4582.358469814229;4959.628027897922;4973.3286006389035;5011.548960593527;5380.784768609251;5593.692346920918;3789.450529673182;3789.82349312477;3798;3855.51806024247;3873.1285460771383;5460.426655201187;5591.2043978011;5629.324481062217;5710.457506536914;5875.472377181921;3757.342465068602;3866.2654095721723;3874.9225015500097;3878.864239751595;3916.6083391661177;3615.5480564929385;3723.3856413691437;3835.983464381941;3972.8609498667406;4005.4792876926394;4409.5149533551285;4450.844220452269;4451.554844515523;4538.591526762607;4623.4451865775645;5387.272718183073;5610.663360198401;5658.773649054074;5669.716514174274;5678.517326027251;1090.373035504588;1124.9100071994221;1174.6843535240414;1230.194222784078;1279.6608898641866;770.5184259837602;845.9492430454193;855.8887344645157;873.3100850328296;874.2001069021774;4326.610605045498;4367.759773212504;4821.783019764119;4901.5588597026435;4950.529699678525;4847.80608775652;5017.724025178651;5102.9489705103215;5384.892302153935;5402.756875940592;4518.367428560005;4598.425196850394;4670.743109129031;4740.360051393087;4970.111357684057;2493.314338556875;2584.625229341735;2775.9306017349727;2794.2455537004894;2834.6173266609158;5291.391489978701;5387.973060134675;5514.09017512106;5557.305336832896;5561.582881283839;4704.764761761899;4875;5283.890383019532;5527.917081243784;5619.381867994517;5197.480251974848;5296.470352964673;5554.888902221933;5579.944200558105;5610.671571297948;5229.136902680543;5374.167004114369;5409.864753381197;5421.132618780976;5468.507834294933;4865.659403841839;5303.4696530346655;5322.866928326823;5342.702637865755;5455.563554915677;4708.905821883474;5625.690587017753;5656.878670498563;5681.630694004876;5703.344115426613;3577.3918433865783;3746.4567637692926;3909.882703518899;4203.558626344312;4205.789710514523;5494.560435165097;5783.739731712168;5800.419958004166;5838.416158384128;5956.463918247378;5194.818181363634;5541.919325731444;5575.553955683617;5624.634398764068;5683.23276357703;4774.594159496482;4997.800527873357;5426.755795989111;5629.662220266797;5667.291588551431;4540.523245059353;5139.631610219904;5379.488948549882;5502.074274004067;5529.695866727368;4663.57760882934;4720.442254056222;4772.236442169236;5133.383993920754;5569.888602227852;4715.844618068595;5257.790708137226;5451.700156491431;5469.179623056573;5474.288342515607 11:13:31 INFO - PROCESS | 1639 | |5;yui.html;698.9510734248605;732.4653003307585;764.6559048428205;823.5305875650879;843.1947490146911;14305;14936;14937.477188298399;14951.775723364131;14964.850351496481;13786.448542058331;13903;13909.860901390983;13925.582232533015;13956.162630242192;865.4331412924513;874.82940826539;887.1217494680252;887.8401887660251;888.5601627194516;898.3666515106867;898.7079199260266;900.5407242306405;900.9234215091725;902.9503377314245;922.9676961306355;947.4315410753561;947.6020071569923;948.9193418559396;952.8665986761858;941.1341565759449;941.7833898203418;941.835178843703;942.9057094290516;943.4905151218334;692.2281655953575;695.6765104226508;696.0637941968045;696.7004188199072;697.9267176946398;14230;14610.926945365312;14633.195174265411;15004.924975375163;15375.384984600603;13748.725025499534;13894.930525347309;13999.89058700077;14021.228832414214;14042.508512202025;11092.389918554476;11246.550137994553;11254.662360129209;11667.591634292843;11799.882001179963;3539.2213712983103;3564.0733409313766;3619.9819000904827;3629.3104310181243;3764.5106136202116;91307;100475.49762251215;104662.4766876176;104710;105532.4723376386;10554.683359499228;10556.419396933243;10644.680659580225;10692.433815884131;11088.33469991803;21042.15831366728;21464.78535214659;21477;21555.137794488044;21608.891955540123;7249.565026098451;7303;7377.81555461107;7491.3632341251605;7571.46999710015;4002.3796311571173;4065.97967010169;4087.5708050654252;4110.445089912823;4178.415021896937;3565.037439891215;3595.658412450813;3630.49173115764;3658.926821463609;3670.504481894963;654.2672207127952;658.9044588534731;662.6686656671665;677.7119724117231;679.4530403025611;647.3429469088878;673.8483841135803;683.6547543490506;688.1707542411382;714.6783947223666;9745.275759725908;9918.15695665862;10054.645898565974;10061.849072263922;10066.647667331608;687.556526040701;693.2963042511855;696.7596179318127;699.5601775121618;711.6370650968043;4722.126406614787;4804.975975120102;4844.878878028077;4898.804047838118;4971.477994810565;94248;96041;97164.51417743007;97523;98233.50883245538;82264.58867705743;82623.58688206521;83087;83896.58051709703;85849;74211.62894185494;75167;75730;75769.6211518939;76533.6173319141;9592.376495527767;9611.663591774255;9628.18160456341;9650.95174524123;9663.516824158905;49328;50097.656250000524;50590.399632063374;51088.74455627698;52392.47607524029;50592.74703626458;62319.753604926744;66603.66698166478;68586.314136858;72827.27172728417;11343.319400835977;11476.254043487146;11525.711857203636;11825.645230643095;11897.82153267719;12785.16896401731;12876.35618219104;13079.803802943154;13238.735225295633;13244.80132798028;11639.709007274885;11699.766004679688;12024.158308918291;12413.44139513706;12447.58110870628;11650;11924.701882453008;12053.337066461429;12428.067894907737;12602.36988150607;11891.643250702493;11910.940445297718;12093.939530302292;12236.95985841178;12312.692182695504;9724.416535007922;10071.19430445548;10096.84854727165;10211.540480678535;10827.566897324019;8196.385271104571;8416.537090460084;9007.864882026644;9604.85592716096;9658.7585310365 11:13:31 INFO - PROCESS | 1639 | __end_tp_report 11:13:31 INFO - PROCESS | 1639 | __start_cc_report 11:13:31 INFO - PROCESS | 1639 | _x_x_mozilla_cycle_collect,2141 11:13:31 INFO - PROCESS | 1639 | __end_cc_report 11:13:31 INFO - PROCESS | 1639 | __startTimestamp1486149210994__endTimestamp 11:13:31 INFO - PROCESS | 1639 | 11:13:31 INFO - PROCESS | 1639 | ------- Summary: start ------- 11:13:31 INFO - PROCESS | 1639 | Number of tests: 6 11:13:31 INFO - PROCESS | 1639 | 11:13:31 INFO - PROCESS | 1639 | [#0] dojo.html Cycles:165 Average:5674.69 Median:5942.76 stddev:668.75 (11.3%) stddev-sans-first:632.47 11:13:31 INFO - PROCESS | 1639 | Values: 2830.0 3305.0 3311.9 3315.4 3377.7 5245.8 5534.6 5613.2 5694.9 5763.0 4514.7 4964.3 5383.3 5626.0 5664.5 5068.5 5124.5 5156.9 5164.4 5220.8 4852.7 5053.5 5255.9 5256.9 5317.7 5082.0 5103.6 5111.2 5122.6 5218.4 5185.9 5235.2 5251.3 5306.9 5313.5 5141.1 5180.9 5181.9 5204.6 5221.8 5521.3 5545.6 5700.8 5707.0 5735.1 6115.0 6147.2 6194.5 6206.4 6258.5 6178.3 6274.4 6281.4 6287.4 6293.6 5758.1 5827.1 5828.7 5840.3 5869.8 6189.4 6206.0 6243.5 6245.3 6245.7 5114.6 6019.9 6022.7 6031.9 6069.9 6178.7 6180.0 6186.6 6191.8 6214.2 5971.7 6008.5 6015.8 6053.4 6136.9 6165.9 6188.8 6189.5 6281.7 6291.1 4940.0 4940.8 4953.8 4955.3 4978.8 3858.3 4460.7 4471.9 4486.6 4511.8 5587.4 5645.6 5672.3 5684.3 5702.3 6226.7 6278.7 6283.2 6284.6 6317.5 5720.7 5722.3 5732.3 5741.8 5758.4 5030.5 5201.3 5215.2 5274.0 5421.5 6209.4 6250.2 6252.8 6252.9 6253.3 6100.1 6102.4 6136.3 6202.4 6222.6 6218.1 6223.2 6232.0 6273.5 6285.7 6187.8 6190.4 6208.2 6213.9 6219.3 5929.5 6061.0 6085.4 6193.2 6194.1 6096.1 6104.2 6124.5 6125.5 6139.2 6068.2 6092.4 6094.0 6106.3 6108.1 4666.0 5584.3 5610.2 5914.1 5941.9 5996.2 6012.8 6053.8 6109.8 6127.9 5942.8 5955.3 5958.4 5962.6 5982.3 11:13:31 INFO - PROCESS | 1639 | 11:13:31 INFO - PROCESS | 1639 | [#1] ext.html Cycles:180 Average:65042.07 Median:38068.62 stddev:136232.79 (357.9%) stddev-sans-first:136528.60 11:13:31 INFO - PROCESS | 1639 | Values: 435.2 444.3 481.4 494.4 495.6 39256.0 41523.0 41817.7 41857.8 43511.1 41645.2 41878.2 41958.2 42030.0 42066.0 8074.7 8261.7 9231.5 9435.5 9454.2 11104.2 11321.7 11342.8 11350.1 11473.4 9648.5 11313.9 11344.3 11361.0 11367.5 8095.0 8303.8 11130.8 11227.0 11304.5 11053.9 11148.7 11151.4 11185.7 11207.9 39562.0 39929.6 39932.8 39986.2 40080.4 3715.5 3845.8 3971.4 3982.6 3986.5 30025.8 30430.8 30443.2 30514.1 30576.7 3084.4 3143.9 3173.7 3280.3 3289.6 426942.0 427041.0 427473.0 428192.0 440117.0 49480.3 50770.0 58935.4 59346.4 59385.7 52856.6 66129.0 67260.0 67302.7 67474.7 15260.5 15307.3 15518.3 15518.6 15574.8 11920.6 12004.9 12008.6 12022.1 12048.5 15586.8 15665.2 15696.8 15701.8 15858.8 6688.3 6717.8 6731.0 6752.4 6765.0 830.4 846.2 881.6 883.4 887.3 27559.6 28027.4 29080.6 29711.4 29831.0 1033.4 1047.2 1071.7 1088.6 1203.6 15161.8 15343.0 15389.9 15547.6 15730.6 585635.0 589739.0 589996.0 590606.0 591508.0 58046.7 58093.4 58110.0 58142.0 58146.7 1386.2 1416.0 1437.8 1443.6 1450.3 28196.4 28921.9 28983.9 29849.8 30275.4 48573.8 50381.0 50446.7 50483.7 50523.0 500701.0 501400.0 502974.0 503586.0 504921.0 32336.9 32980.2 33089.8 37927.6 38211.2 43602.8 45568.0 45881.0 47193.8 47478.8 37737.2 37998.8 38133.6 38906.6 39397.8 37470.8 38003.6 38241.0 39016.8 39761.8 29645.6 36229.6 36521.3 36627.5 37116.8 32314.7 33301.5 33535.5 33706.5 33763.0 23098.0 24736.1 24764.8 24936.9 25009.0 11:13:31 INFO - PROCESS | 1639 | 11:13:31 INFO - PROCESS | 1639 | [#2] jquery.html Cycles:180 Average:38676.80 Median:20898.29 stddev:119973.94 (574.1%) stddev-sans-first:120276.07 11:13:31 INFO - PROCESS | 1639 | Values: 400.1 401.3 404.4 414.3 432.3 13963.7 19679.0 20851.0 20901.7 20947.2 20670.6 20772.8 21114.7 21167.3 21441.5 5841.4 6188.5 6198.9 6199.7 6203.2 5286.4 5469.3 6050.5 6102.1 6192.6 6086.8 6095.1 6101.5 6110.1 6118.5 5829.5 6026.8 6079.2 6087.1 6099.7 5345.5 5364.5 5373.7 5375.3 5379.1 26443.7 26679.0 26680.7 26881.5 26983.8 2680.6 2725.6 2744.9 2745.9 2788.4 15275.0 15833.1 16016.9 16167.2 16818.2 1797.1 1821.0 1844.1 1870.6 1892.3 124427.1 125294.4 131162.3 132312.7 135269.0 11181.2 11746.8 11782.6 11796.9 11969.3 12641.9 14039.0 15344.5 15361.3 15400.1 6683.9 7872.7 8559.8 8706.0 8716.5 7212.4 8512.1 8522.6 8574.7 8625.7 6783.1 7224.3 7333.3 7366.7 7437.0 1729.9 1920.9 1975.9 1983.6 1987.4 1014.3 1015.1 1023.4 1042.8 1075.5 17504.5 19741.6 20494.8 20894.9 21129.0 1037.8 1039.6 1043.2 1068.8 1076.3 10726.7 11066.3 11073.8 11122.9 11141.8 712305.0 721317.0 723273.0 723419.0 742219.0 107545.0 107722.9 130637.0 131884.3 136377.0 908.3 1011.7 1027.0 1027.7 1029.2 17801.6 17928.9 18246.3 18452.3 18516.4 49502.0 50682.5 50913.5 50995.7 52262.0 72023.3 73374.6 73476.3 73499.0 73933.0 6176.7 6320.5 6326.2 6463.2 6596.8 12425.4 12661.3 13077.6 13087.0 13209.6 10121.5 10283.2 10892.7 10903.1 11047.1 10939.7 10969.1 11039.1 11235.0 11238.5 10476.9 10920.6 11274.3 11440.7 11863.5 7326.8 8332.4 8474.0 8577.2 8771.6 5690.8 6067.4 10918.5 11443.9 11674.6 11:13:31 INFO - PROCESS | 1639 | 11:13:31 INFO - PROCESS | 1639 | [#3] mootools.html Cycles:180 Average:5455.50 Median:5160.90 stddev:3067.12 (59.4%) stddev-sans-first:3060.59 11:13:31 INFO - PROCESS | 1639 | Values: 1400.6 1417.4 1436.1 1440.9 1445.7 8288.8 8586.4 8610.3 8728.7 8747.1 8256.5 8398.7 8576.9 8633.4 8647.3 2261.4 2290.6 2298.2 2298.7 2300.6 2009.5 2268.1 2317.8 2324.8 2325.1 2029.1 2060.9 2062.5 2063.6 2262.4 2286.7 2295.6 2301.9 2316.4 2317.6 2252.3 2317.6 2345.0 2352.3 2354.6 8685.7 8753.3 8762.9 8763.2 8771.3 4777.4 5154.9 5208.6 5317.0 5328.6 3323.7 3481.7 3505.0 3550.9 3571.8 1177.2 1215.7 1224.0 1270.8 1271.8 11092.5 11185.4 11241.3 11250.4 11260.1 4286.5 4454.8 4541.9 4560.1 4593.0 8813.4 8817.5 8824.6 8833.4 8852.8 5122.4 5166.8 5181.8 5183.4 5195.1 4669.8 4752.3 4778.2 4798.2 4848.2 3320.9 3402.9 3601.1 3614.5 3644.5 1104.6 1110.4 1112.2 1122.5 1128.5 742.9 743.7 766.9 771.9 800.4 5391.1 5489.5 5557.2 5573.0 5626.7 537.1 557.2 574.0 586.9 587.1 3615.3 3643.7 3708.9 3724.7 3756.9 10068.7 10458.7 10473.3 10485.7 10494.3 10099.6 10248.7 10273.3 10400.3 10419.1 7804.7 7861.5 7982.9 8028.2 8065.0 5327.5 5426.0 5516.3 5518.0 5758.3 8123.7 9285.1 9300.5 9422.6 9545.0 8399.9 9454.9 9741.2 9818.5 9842.0 6712.7 6895.2 6901.4 6901.5 6919.2 7963.5 7989.5 8019.2 8114.1 8159.9 5751.8 6484.8 7254.8 7313.2 7529.0 7185.5 7232.2 7247.6 7260.6 7279.5 6336.5 6421.0 6479.8 6487.2 6496.9 4916.7 4949.0 4966.3 5064.4 5223.5 5017.4 5080.6 5094.6 5142.6 5290.4 11:13:31 INFO - PROCESS | 1639 | 11:13:31 INFO - PROCESS | 1639 | [#4] prototype.html Cycles:180 Average:4427.43 Median:4888.28 stddev:1341.31 (27.4%) stddev-sans-first:1309.84 11:13:31 INFO - PROCESS | 1639 | Values: 358.3 358.9 371.1 375.5 376.7 5164.4 5226.9 5392.5 5422.8 5505.0 4835.0 5211.9 5250.5 5251.9 5344.9 3645.3 3874.7 4057.1 4084.7 4089.8 3491.7 3581.7 3621.6 4093.9 4124.9 3475.9 3986.9 4061.4 4069.4 4071.5 3535.8 3943.0 4013.5 4031.0 4040.8 3498.0 3537.5 3539.4 3541.5 3556.7 4246.6 4532.7 5265.7 5277.4 5373.1 4518.8 4520.8 4527.7 4550.0 4582.4 4959.6 4973.3 5011.5 5380.8 5593.7 3789.5 3789.8 3798.0 3855.5 3873.1 5460.4 5591.2 5629.3 5710.5 5875.5 3757.3 3866.3 3874.9 3878.9 3916.6 3615.5 3723.4 3836.0 3972.9 4005.5 4409.5 4450.8 4451.6 4538.6 4623.4 5387.3 5610.7 5658.8 5669.7 5678.5 1090.4 1124.9 1174.7 1230.2 1279.7 770.5 845.9 855.9 873.3 874.2 4326.6 4367.8 4821.8 4901.6 4950.5 4847.8 5017.7 5102.9 5384.9 5402.8 4518.4 4598.4 4670.7 4740.4 4970.1 2493.3 2584.6 2775.9 2794.2 2834.6 5291.4 5388.0 5514.1 5557.3 5561.6 4704.8 4875.0 5283.9 5527.9 5619.4 5197.5 5296.5 5554.9 5579.9 5610.7 5229.1 5374.2 5409.9 5421.1 5468.5 4865.7 5303.5 5322.9 5342.7 5455.6 4708.9 5625.7 5656.9 5681.6 5703.3 3577.4 3746.5 3909.9 4203.6 4205.8 5494.6 5783.7 5800.4 5838.4 5956.5 5194.8 5541.9 5575.6 5624.6 5683.2 4774.6 4997.8 5426.8 5629.7 5667.3 4540.5 5139.6 5379.5 5502.1 5529.7 4663.6 4720.4 4772.2 5133.4 5569.9 4715.8 5257.8 5451.7 5469.2 5474.3 11:13:31 INFO - PROCESS | 1639 | 11:13:31 INFO - PROCESS | 1639 | [#5] yui.html Cycles:180 Average:19536.65 Median:27149.74 stddev:28018.68 (103.2%) stddev-sans-first:28061.58 11:13:31 INFO - PROCESS | 1639 | Values: 699.0 732.5 764.7 823.5 843.2 14305.0 14936.0 14937.5 14951.8 14964.9 13786.4 13903.0 13909.9 13925.6 13956.2 865.4 874.8 887.1 887.8 888.6 898.4 898.7 900.5 900.9 903.0 923.0 947.4 947.6 948.9 952.9 941.1 941.8 941.8 942.9 943.5 692.2 695.7 696.1 696.7 697.9 14230.0 14610.9 14633.2 15004.9 15375.4 13748.7 13894.9 13999.9 14021.2 14042.5 11092.4 11246.6 11254.7 11667.6 11799.9 3539.2 3564.1 3620.0 3629.3 3764.5 91307.0 100475.5 104662.5 104710.0 105532.5 10554.7 10556.4 10644.7 10692.4 11088.3 21042.2 21464.8 21477.0 21555.1 21608.9 7249.6 7303.0 7377.8 7491.4 7571.5 4002.4 4066.0 4087.6 4110.4 4178.4 3565.0 3595.7 3630.5 3658.9 3670.5 654.3 658.9 662.7 677.7 679.5 647.3 673.8 683.7 688.2 714.7 9745.3 9918.2 10054.6 10061.8 10066.6 687.6 693.3 696.8 699.6 711.6 4722.1 4805.0 4844.9 4898.8 4971.5 94248.0 96041.0 97164.5 97523.0 98233.5 82264.6 82623.6 83087.0 83896.6 85849.0 74211.6 75167.0 75730.0 75769.6 76533.6 9592.4 9611.7 9628.2 9651.0 9663.5 49328.0 50097.7 50590.4 51088.7 52392.5 50592.7 62319.8 66603.7 68586.3 72827.3 11343.3 11476.3 11525.7 11825.6 11897.8 12785.2 12876.4 13079.8 13238.7 13244.8 11639.7 11699.8 12024.2 12413.4 12447.6 11650.0 11924.7 12053.3 12428.1 12602.4 11891.6 11910.9 12093.9 12237.0 12312.7 9724.4 10071.2 10096.8 10211.5 10827.6 8196.4 8416.5 9007.9 9604.9 9658.8 11:13:31 INFO - PROCESS | 1639 | -------- Summary: end -------- 11:13:31 INFO - PROCESS | 1639 | 11:13:31 INFO - TEST-INFO | 1639: exit 0 11:13:31 INFO - TEST-OK | dromaeo_css | took 1118853ms 11:13:31 INFO - TEST-START | kraken 11:13:31 INFO - operating with platform_type : mac_ 11:13:31 INFO - Initialising browser for kraken test... 11:13:31 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/tmpNn_1wQ/profile http://localhost:49243/getInfo.html) 11:13:33 INFO - PROCESS | 1650 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 11:13:33 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 11:13:33 INFO - PROCESS | 1650 | colorDepth:24 11:13:33 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 11:13:33 INFO - PROCESS | 1650 | __metrics 11:13:33 INFO - PROCESS | 1650 | 1486149213975 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 11:13:34 INFO - PROCESS | 1650 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:13:34 INFO - PROCESS | 1650 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:13:34 INFO - TEST-INFO | 1650: exit 0 11:13:34 INFO - Browser initialized. 11:13:34 INFO - Running cycle 1/1 for kraken test... 11:13:34 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/tmpNn_1wQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:13:47 INFO - PROCESS | 1651 | RSS: Main: 236625920 11:13:47 INFO - PROCESS | 1651 | 11:13:49 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 11:13:50 INFO - PROCESS | 1651 | RSS: Main: 289452032 11:13:50 INFO - PROCESS | 1651 | 11:13:53 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 11:13:54 INFO - PROCESS | 1651 | RSS: Main: 291729408 11:13:54 INFO - PROCESS | 1651 | 11:13:57 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 11:13:58 INFO - PROCESS | 1651 | RSS: Main: 382234624 11:13:58 INFO - PROCESS | 1651 | 11:14:00 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 11:14:00 INFO - PROCESS | 1651 | RSS: Main: 283758592 11:14:00 INFO - PROCESS | 1651 | 11:14:02 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:14:03 INFO - PROCESS | 1651 | RSS: Main: 286396416 11:14:03 INFO - PROCESS | 1651 | 11:14:06 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 11:14:06 INFO - PROCESS | 1651 | RSS: Main: 328859648 11:14:06 INFO - PROCESS | 1651 | 11:14:09 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 11:14:10 INFO - PROCESS | 1651 | RSS: Main: 330993664 11:14:10 INFO - PROCESS | 1651 | 11:14:13 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 11:14:13 INFO - PROCESS | 1651 | RSS: Main: 327057408 11:14:13 INFO - PROCESS | 1651 | 11:14:15 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:14:16 INFO - PROCESS | 1651 | RSS: Main: 304214016 11:14:16 INFO - PROCESS | 1651 | 11:14:17 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:14:18 INFO - PROCESS | 1651 | RSS: Main: 310824960 11:14:18 INFO - PROCESS | 1651 | 11:14:20 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:14:21 INFO - PROCESS | 1651 | RSS: Main: 311087104 11:14:21 INFO - PROCESS | 1651 | 11:14:24 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:14:25 INFO - PROCESS | 1651 | RSS: Main: 327847936 11:14:25 INFO - PROCESS | 1651 | 11:14:28 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:14:28 INFO - PROCESS | 1651 | RSS: Main: 322187264 11:14:28 INFO - PROCESS | 1651 | 11:14:30 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 11:14:30 INFO - PROCESS | 1651 | RSS: Main: 367456256 11:14:30 INFO - PROCESS | 1651 | 11:14:30 INFO - PROCESS | 1651 | __start_tp_report 11:14:30 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 11:14:30 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 11:14:30 INFO - PROCESS | 1651 | |i|pagename|runs| 11:14:30 INFO - PROCESS | 1651 | |0;ai-astar;115;115;115;112;114;114;114;115;115;115 11:14:30 INFO - PROCESS | 1651 | |1;audio-beat-detection;144;103;129;169;133;108;109;103;129;110 11:14:30 INFO - PROCESS | 1651 | |2;audio-dft;206;248;189;187;179;184;184;183;185;182 11:14:30 INFO - PROCESS | 1651 | |3;audio-fft;81;54;55;85;81;59;58;57;72;59 11:14:30 INFO - PROCESS | 1651 | |4;audio-oscillator;88;71;87;70;68;70;85;68;69;84 11:14:30 INFO - PROCESS | 1651 | |5;imaging-gaussian-blur;88;87;88;84;89;85;89;85;87;84 11:14:30 INFO - PROCESS | 1651 | |6;imaging-darkroom;94;94;95;95;93;95;95;96;95;95 11:14:30 INFO - PROCESS | 1651 | |7;imaging-desaturate;83;83;86;86;89;86;86;84;85;85 11:14:30 INFO - PROCESS | 1651 | |8;json-parse-financial;62;57;58;58;59;59;59;59;58;58 11:14:30 INFO - PROCESS | 1651 | |9;json-stringify-tinderbox;73;71;76;79;73;70;71;71;72;72 11:14:30 INFO - PROCESS | 1651 | |10;stanford-crypto-aes;85;85;87;88;86;85;86;86;83;90 11:14:30 INFO - PROCESS | 1651 | |11;stanford-crypto-ccm;145;148;148;140;138;142;144;142;189;164 11:14:30 INFO - PROCESS | 1651 | |12;stanford-crypto-pbkdf2;175;173;173;172;177;171;172;173;171;173 11:14:30 INFO - PROCESS | 1651 | |13;stanford-crypto-sha256-iterative;66;67;66;67;68;65;65;67;67;66 11:14:30 INFO - PROCESS | 1651 | __end_tp_report 11:14:30 INFO - PROCESS | 1651 | __start_cc_report 11:14:30 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,2119 11:14:30 INFO - PROCESS | 1651 | __end_cc_report 11:14:30 INFO - PROCESS | 1651 | __startTimestamp1486149270806__endTimestamp 11:14:30 INFO - PROCESS | 1651 | 11:14:30 INFO - PROCESS | 1651 | ------- Summary: start ------- 11:14:30 INFO - PROCESS | 1651 | Number of tests: 14 11:14:30 INFO - PROCESS | 1651 | 11:14:30 INFO - PROCESS | 1651 | [#0] ai-astar Cycles:10 Average:114.40 Median:115.00 stddev:0.97 (0.8%) stddev-sans-first:1.00 11:14:30 INFO - PROCESS | 1651 | Values: 115.0 115.0 115.0 112.0 114.0 114.0 114.0 115.0 115.0 115.0 11:14:30 INFO - PROCESS | 1651 | 11:14:30 INFO - PROCESS | 1651 | [#1] audio-beat-detection Cycles:10 Average:123.70 Median:129.00 stddev:21.38 (16.6%) stddev-sans-first:21.38 11:14:30 INFO - PROCESS | 1651 | Values: 144.0 103.0 129.0 169.0 133.0 108.0 109.0 103.0 129.0 110.0 11:14:30 INFO - PROCESS | 1651 | 11:14:30 INFO - PROCESS | 1651 | [#2] audio-dft Cycles:10 Average:192.70 Median:186.00 stddev:20.78 (11.2%) stddev-sans-first:21.48 11:14:30 INFO - PROCESS | 1651 | Values: 206.0 248.0 189.0 187.0 179.0 184.0 184.0 183.0 185.0 182.0 11:14:30 INFO - PROCESS | 1651 | 11:14:30 INFO - PROCESS | 1651 | [#3] audio-fft Cycles:10 Average:66.10 Median:65.50 stddev:12.27 (18.7%) stddev-sans-first:11.77 11:14:30 INFO - PROCESS | 1651 | Values: 81.0 54.0 55.0 85.0 81.0 59.0 58.0 57.0 72.0 59.0 11:14:30 INFO - PROCESS | 1651 | 11:14:30 INFO - PROCESS | 1651 | [#4] audio-oscillator Cycles:10 Average:76.00 Median:77.50 stddev:8.72 (11.2%) stddev-sans-first:8.09 11:14:30 INFO - PROCESS | 1651 | Values: 88.0 71.0 87.0 70.0 68.0 70.0 85.0 68.0 69.0 84.0 11:14:30 INFO - PROCESS | 1651 | 11:14:30 INFO - PROCESS | 1651 | [#5] imaging-gaussian-blur Cycles:10 Average:86.60 Median:87.50 stddev:1.96 (2.2%) stddev-sans-first:2.01 11:14:30 INFO - PROCESS | 1651 | Values: 88.0 87.0 88.0 84.0 89.0 85.0 89.0 85.0 87.0 84.0 11:14:30 INFO - PROCESS | 1651 | 11:14:30 INFO - PROCESS | 1651 | [#6] imaging-darkroom Cycles:10 Average:94.70 Median:95.00 stddev:0.82 (0.9%) stddev-sans-first:0.83 11:14:30 INFO - PROCESS | 1651 | Values: 94.0 94.0 95.0 95.0 93.0 95.0 95.0 96.0 95.0 95.0 11:14:30 INFO - PROCESS | 1651 | 11:14:30 INFO - PROCESS | 1651 | [#7] imaging-desaturate Cycles:10 Average:85.30 Median:86.00 stddev:1.77 (2.1%) stddev-sans-first:1.67 11:14:30 INFO - PROCESS | 1651 | Values: 83.0 83.0 86.0 86.0 89.0 86.0 86.0 84.0 85.0 85.0 11:14:30 INFO - PROCESS | 1651 | 11:14:30 INFO - PROCESS | 1651 | [#8] json-parse-financial Cycles:10 Average:58.70 Median:59.00 stddev:1.34 (2.3%) stddev-sans-first:0.71 11:14:30 INFO - PROCESS | 1651 | Values: 62.0 57.0 58.0 58.0 59.0 59.0 59.0 59.0 58.0 58.0 11:14:30 INFO - PROCESS | 1651 | 11:14:30 INFO - PROCESS | 1651 | [#9] json-stringify-tinderbox Cycles:10 Average:72.80 Median:72.50 stddev:2.74 (3.8%) stddev-sans-first:2.91 11:14:30 INFO - PROCESS | 1651 | Values: 73.0 71.0 76.0 79.0 73.0 70.0 71.0 71.0 72.0 72.0 11:14:30 INFO - PROCESS | 1651 | 11:14:30 INFO - PROCESS | 1651 | [#10] stanford-crypto-aes Cycles:10 Average:86.10 Median:86.00 stddev:1.91 (2.2%) stddev-sans-first:1.99 11:14:30 INFO - PROCESS | 1651 | Values: 85.0 85.0 87.0 88.0 86.0 85.0 86.0 86.0 83.0 90.0 11:14:30 INFO - PROCESS | 1651 | 11:14:30 INFO - PROCESS | 1651 | [#11] stanford-crypto-ccm Cycles:10 Average:150.00 Median:146.50 stddev:15.48 (10.6%) stddev-sans-first:16.32 11:14:30 INFO - PROCESS | 1651 | Values: 145.0 148.0 148.0 140.0 138.0 142.0 144.0 142.0 189.0 164.0 11:14:30 INFO - PROCESS | 1651 | 11:14:30 INFO - PROCESS | 1651 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.00 Median:173.00 stddev:1.83 (1.1%) stddev-sans-first:1.79 11:14:30 INFO - PROCESS | 1651 | Values: 175.0 173.0 173.0 172.0 177.0 171.0 172.0 173.0 171.0 173.0 11:14:30 INFO - PROCESS | 1651 | 11:14:30 INFO - PROCESS | 1651 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:67.00 stddev:0.97 (1.4%) stddev-sans-first:1.01 11:14:30 INFO - PROCESS | 1651 | Values: 66.0 67.0 66.0 67.0 68.0 65.0 65.0 67.0 67.0 66.0 11:14:30 INFO - PROCESS | 1651 | -------- Summary: end -------- 11:14:30 INFO - PROCESS | 1651 | 11:14:31 INFO - TEST-INFO | 1651: exit 0 11:14:31 INFO - TEST-OK | kraken | took 60201ms 11:14:31 INFO - SUITE-END | took 1179s 11:14:31 INFO - Completed test suite (00:19:39) 11:14:31 INFO - javascript benchmark 11:14:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7202.031228060322, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2829.9575506367396, 3304.9919774468794, 3311.9172020699493, 3315.4032274190645, 3377.679120483553, 5245.793467502477, 5534.640248383862, 5613.18608801724, 5694.857628559283, 5763.020286551291, 4514.706544074641, 4964.280179373988, 5383.327084114486, 5625.987322281988, 5664.518515926141, 5068.49315068493, 5124.538791508763, 5156.92264616031, 5164.406093299281, 5220.817271395502, 4852.708837469745, 5053.469385714502, 5255.894882102356, 5256.8685782855355, 5317.6809391436445, 5082.034413461467, 5103.56619687327, 5111.2333150027425, 5122.641415100945, 5218.373795144588, 5185.948140518584, 5235.240890070956, 5251.291075704769, 5306.92039619406, 5313.548348390392, 5141.100307446182, 5180.922286165711, 5181.896362072775, 5204.609654275944, 5221.843344699665, 5521.254630624854, 5545.611807173499, 5700.828975130711, 5707.0298049331295, 5735.139729040636, 6115.0, 6147.2008638877105, 6194.5354098442795, 6206.441420272197, 6258.4680302174365, 6178.289496707891, 6274.403931626533, 6281.403266689657, 6287.402696743802, 6293.559450838443, 5758.078707406795, 5827.067669172912, 5828.65028098307, 5840.269966254218, 5869.7652093916195, 6189.412005859436, 6206.0, 6243.531735119794, 6245.250569931637, 6245.656488893154, 5114.616403769732, 6019.909701354483, 6022.668753218615, 6031.8793624127275, 6069.908951365733, 6178.7219575119225, 6179.969100154561, 6186.597871138361, 6191.81424557264, 6214.161088253119, 5971.731272092767, 6008.459238668541, 6015.819525414157, 6053.364396738367, 6136.8772624547255, 6165.907511387333, 6188.81433556994, 6189.473894718909, 6281.654509002049, 6291.056341548804, 4940.011997600423, 4940.802367905244, 4953.777080031407, 4955.281484184773, 4978.77595508203, 3858.2862170498547, 4460.710053846489, 4471.865844024619, 4486.6186374157905, 4511.751853648016, 5587.44125587438, 5645.576581756302, 5672.319321681424, 5684.289463817023, 5702.315722113373, 6226.688665566794, 6278.717457714414, 6283.214598175228, 6284.591501552384, 6317.4630156437215, 5720.685362305113, 5722.341930677942, 5732.34078081026, 5741.799037033684, 5758.424157584208, 5030.522100400529, 5201.271821944931, 5215.243789650555, 5274.0, 5421.484958928895, 6209.379062093754, 6250.249970003629, 6252.812415627538, 6252.937470625236, 6253.280872699698, 6100.054491553817, 6102.398363691488, 6136.2636483622255, 6202.4417802398, 6222.62664240147, 6218.129461875251, 6223.222097237845, 6232.0, 6273.52948528853, 6285.748570057147, 6187.81436556904, 6190.350013248724, 6208.192934918432, 6213.875722485615, 6219.346968568235, 5929.52563794904, 6061.0, 6085.391460853879, 6193.194884665145, 6194.0708893666315, 6096.116063170904, 6104.246950856165, 6124.54065945047, 6125.509959203342, 6139.2325959255095, 6068.241469816273, 6092.421219984094, 6094.0, 6106.267247930276, 6108.08378743192, 4665.976670116627, 5584.301962254718, 5610.18652295423, 5914.112883067574, 5941.881162376815, 5996.190514280516, 6012.789552365646, 6053.848653783691, 6109.84725381869, 6127.938720612737, 5942.762289508371, 5955.315138758925, 5958.404159584007, 5962.582619216613, 5982.341942386247], "value": 5630.196823099631, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [435.2383329173946, 444.29357321858237, 481.41267653462785, 494.3746161106199, 495.6158976792985, 39256.0, 41523.0, 41817.74546763594, 41857.7907110464, 43511.129777404436, 41645.16709665805, 41878.16243675125, 41958.160836783245, 42030.0, 42066.0, 8074.71738489153, 8261.669533218694, 9231.538423078837, 9435.528223588793, 9454.196393306578, 11104.222704410655, 11321.660350189466, 11342.773144537105, 11350.09199264061, 11473.426328683574, 9648.469334186617, 11313.886861131406, 11344.319340839535, 11361.0, 11367.545298188104, 8095.0, 8303.750887473325, 11130.777384452347, 11227.0, 11304.547818087267, 11053.889461105447, 11148.665540033811, 11151.38667373294, 11185.66443006711, 11207.887921120766, 39562.0109497262, 39929.60070399288, 39932.80033599814, 39986.20027599432, 40080.39879401811, 3715.535558055243, 3845.807709614536, 3971.384435412516, 3982.6415622594104, 3986.521617405901, 30025.798968041254, 30430.84784576063, 30443.23891902698, 30514.084577462712, 30576.694233057606, 3084.36770462057, 3143.9214019649694, 3173.730232930204, 3280.2619410632656, 3289.605247370307, 426942.0, 427041.0, 427473.0, 428191.99999999686, 440117.0, 49480.268190613155, 50770.0, 58935.41064589385, 59346.40653593409, 59385.70307148523, 52856.62145203475, 66129.0, 67260.0, 67302.66348668226, 67474.66262668655, 15260.46588369424, 15307.311170997333, 15518.301676424588, 15518.612034699223, 15574.766378504331, 11920.582779602672, 12004.879951200552, 12008.579699710468, 12022.098342624338, 12048.457819397972, 15586.844131558766, 15665.216739162996, 15696.76454853178, 15701.764473532907, 15858.762118568231, 6688.29772873851, 6717.832054198684, 6731.014350766535, 6752.3922846944015, 6765.0, 830.4021104804531, 846.229930763015, 881.6297155194834, 883.4346018548134, 887.272436601993, 27559.586606200923, 28027.439451210863, 29080.563791543143, 29711.40577188444, 29831.0, 1033.4316126130598, 1047.1518070363031, 1071.689210129054, 1088.5917780832187, 1203.5907791350808, 15161.848381516043, 15343.00270482415, 15389.923050384676, 15547.636065557364, 15730.606734831492, 585635.0, 589739.0, 589996.0, 590606.0, 591508.0, 58046.7097664509, 58093.41906580965, 58110.0, 58142.0, 58146.7092664534, 1386.244496749274, 1416.0370947755625, 1437.8274607047222, 1443.6246575890134, 1450.2966061460183, 28196.43607127887, 28921.85539072291, 28983.85508072446, 29849.806007759445, 30275.394492110474, 48573.757131215534, 50381.0, 50446.73883152804, 50483.74758126186, 50522.989540208255, 500701.0, 501400.0, 502974.0, 503586.0, 504921.0, 32336.868209612552, 32980.17549561184, 33089.834550827094, 37927.620723793516, 38211.23577528489, 43602.78198608987, 45568.0, 45881.0, 47193.76403117963, 47478.81302967454, 37737.245255094196, 37998.77010454142, 38133.61866381301, 38906.6109338903, 39397.80301098591, 37470.812645936596, 38003.61996380001, 38241.04397390087, 39016.80491597524, 39761.80119099386, 29645.5553166707, 36229.63770362368, 36521.269574608894, 36627.45058824173, 37116.81441592775, 32314.676853231165, 33301.50047749237, 33535.52172534122, 33706.494402584474, 33762.987110386726, 23098.0, 24736.134235301677, 24764.752352476244, 24936.875315623307, 25008.999640014925], "value": 19798.094827197263, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [400.09777950721156, 401.3017349811328, 404.3994667918141, 414.2688155405709, 432.3083067092652, 13963.720725585483, 19679.0, 20850.99999999998, 20901.686474702892, 20947.16211351548, 20670.586588268226, 20772.792272077273, 21114.683279750818, 21167.259145929896, 21441.46396340092, 5841.357450680422, 6188.5358598105095, 6198.946179149533, 6199.69001549923, 6203.193584833965, 5286.444923283038, 5469.316335458067, 6050.515958723314, 6102.084687296919, 6192.628442293454, 6086.813071451069, 6095.085737139442, 6101.481374083208, 6110.052941794007, 6118.510519158456, 5829.504492118175, 6026.758929642809, 6079.179310793031, 6087.0869369594475, 6099.725512351911, 5345.518903298683, 5364.517193452569, 5373.6775793452125, 5375.274337964363, 5379.085555455582, 26443.73556264432, 26679.0, 26680.73319266802, 26881.46237075267, 26983.78572964221, 2680.624712540246, 2725.645666063399, 2744.862756862149, 2745.890164393422, 2788.3586775041854, 15275.0, 15833.050016999017, 16016.919915400465, 16167.191640417932, 16818.243179056848, 1797.1373740604583, 1820.9635807283912, 1844.124041080476, 1870.5510677437453, 1892.3376818113688, 124427.13359299618, 125294.37352813178, 131162.34418827845, 132312.676873231, 135269.0, 11181.161412893904, 11746.765064698659, 11782.587609433629, 11796.88203117975, 11969.281843089442, 12641.87358126407, 14039.017268791291, 15344.462943796914, 15361.308741106677, 15400.075995440086, 6683.899741503881, 7872.72445464406, 8559.786005349792, 8706.0, 8716.477011379211, 7212.386947109554, 8512.063672995966, 8522.573871306535, 8574.699885503978, 8625.654973800978, 6783.050372947791, 7224.313690199423, 7333.260037380974, 7366.668499917517, 7436.9850275729395, 1729.8529624981766, 1920.932767353136, 1975.8616896817373, 1983.6231116087897, 1987.4137129546818, 1014.2899970020867, 1015.1067060986285, 1023.3552861697083, 1042.8487869258915, 1075.499892549968, 17504.474865754048, 19741.605167896563, 20494.79505204929, 20894.895525522577, 21129.0, 1037.7768779712246, 1039.5841663334727, 1043.2488608202082, 1068.8183008888507, 1076.34343050739, 10726.73183170427, 11066.28069175501, 11073.778524429466, 11122.944385278022, 11141.777164456666, 712305.0, 721317.0, 723273.0, 723419.0, 742219.0, 107545.0, 107722.92277077286, 130637.0, 131884.34057829648, 136377.0, 908.3414524469706, 1011.701548043329, 1027.0499787696351, 1027.732789474742, 1029.2280789407944, 17801.554961126076, 17928.92426454417, 18246.270149194414, 18452.327763381247, 18516.444506664822, 49502.0, 50682.49317506778, 50913.49086509088, 50995.72510687114, 52262.0, 72023.27976720166, 73374.63312683403, 73476.26523734695, 73499.0, 73933.0, 6176.66028368444, 6320.525960553069, 6326.2092238470195, 6463.224413070461, 6596.835079122869, 12425.440855161358, 12661.303628300531, 13077.607671769862, 13087.0, 13209.603711888658, 10121.544530495998, 10283.228757843042, 10892.673219803419, 10903.073238774792, 11047.116230701364, 10939.726506837393, 10969.067629251604, 11039.116870650489, 11235.0, 11238.494267757807, 10476.895231047896, 10920.617778377718, 11274.267172633752, 11440.713982150513, 11863.525458981889, 7326.780196594111, 8332.375071869512, 8473.95763021181, 8577.228049475578, 8771.605277762388, 5690.829275121753, 6067.362926892612, 10918.50866710984, 11443.885561144281, 11674.591389301333], "value": 9870.854543260019, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1400.6428360768004, 1417.4471955937186, 1436.0952599862078, 1440.9207493587862, 1445.6891768269822, 8288.751337459878, 8586.398952073358, 8610.268127209194, 8728.650853965833, 8747.08155643657, 8256.545889976049, 8398.706045288416, 8576.914230857705, 8633.438826476275, 8647.264982476498, 2261.434641339661, 2290.5533420982915, 2298.1726578431753, 2298.712660917385, 2300.64340027296, 2009.457446489447, 2268.092762894847, 2317.8145748340175, 2324.779145981129, 2325.093213646679, 2029.147757941668, 2060.8969551522437, 2062.5153089024066, 2063.5967542071385, 2262.3891549281684, 2286.6570014497793, 2295.6097463431256, 2301.9424514387106, 2316.420894776306, 2317.6291793313158, 2252.2905284835388, 2317.571249318881, 2344.9882750586307, 2352.2590384028977, 2354.5644055849552, 8685.652573897036, 8753.343499237582, 8762.86855697165, 8763.211310981978, 8771.342149338825, 4777.402824646919, 5154.948450515484, 5208.5572726318305, 5316.973415132899, 5328.573714102862, 3323.6842499962463, 3481.651834816523, 3504.9649503505148, 3550.91122721934, 3571.821408929543, 1177.164213408481, 1215.7143071378218, 1223.9571614993522, 1270.761008017185, 1271.8219449277108, 11092.500837462252, 11185.384803835786, 11241.325520468798, 11250.437478126061, 11260.099192064616, 4286.464191976003, 4454.821807127743, 4541.931871021938, 4560.087982403533, 4592.954070459253, 8813.42712723671, 8817.515036672916, 8824.558772061371, 8833.425827321204, 8852.822943541094, 5122.436531981479, 5166.844994650167, 5181.766820493087, 5183.429822719498, 5195.064888320138, 4669.813207471731, 4752.263399173134, 4778.180768867194, 4798.2082956311815, 4848.248521479177, 3320.887502686627, 3402.8808991685173, 3601.081724160322, 3614.4578313253223, 3644.489771432002, 1104.5857803323754, 1110.4281295133012, 1112.2047735868894, 1122.5341483284508, 1128.537299707116, 742.8922806193071, 743.6579173580105, 766.8811334243201, 771.8803585444265, 800.4156965415164, 5391.110466772939, 5489.505944465017, 5557.249771280825, 5573.0, 5626.690532020778, 537.1432565058725, 557.2143277978032, 573.9827805165852, 586.8708884045503, 587.1427715535366, 3615.313090512794, 3643.744937854378, 3708.9072773180346, 3724.7392682512505, 3756.9436458453147, 10068.748281293027, 10458.738531536772, 10473.266871318934, 10485.68542943713, 10494.317869338469, 10099.64651237218, 10248.692539223835, 10273.332233404804, 10400.27198096126, 10419.114375278186, 7804.68781248755, 7861.52830830152, 7982.880256796153, 8028.237317454832, 8064.999999999883, 5327.520523152934, 5425.972870135782, 5516.310461192351, 5518.006758783297, 5758.2514273144225, 8123.6750529978135, 9285.117913798178, 9300.534973251446, 9422.62309507612, 9545.0, 8399.916000840158, 9454.858177127211, 9741.220702343937, 9818.509074546388, 9841.950790246003, 6712.6979285931275, 6895.172579290517, 6901.378875901193, 6901.482388820758, 6919.238883722887, 7963.482373645695, 7989.520628762293, 8019.238172373615, 8114.148014458633, 8159.877601836096, 5751.798687045934, 6484.773032943825, 7254.818629534304, 7313.195548489555, 7528.983452947567, 7185.53294035886, 7232.168300645493, 7247.601381924045, 7260.600666963368, 7279.4540409470565, 6336.4614007808, 6420.967895160495, 6479.773207937888, 6487.156669632917, 6496.870062598627, 4916.680415772963, 4948.950510494993, 4966.279889416087, 5064.442911279682, 5223.4515375884985, 5017.448080711192, 5080.593552515864, 5094.592432605308, 5142.614303927146, 5290.365156181283], "value": 4330.614859606401, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.25661751864885, 358.8959201831469, 371.1130398347948, 375.4799602550467, 376.7438142063396, 5164.354455693038, 5226.921596176051, 5392.541633961113, 5422.810201642943, 5504.972475137623, 4834.975825120879, 5211.86970325742, 5250.501202385777, 5251.894962100756, 5344.91982620261, 3645.270945810835, 3874.6900247980166, 4057.1479989202157, 4084.7140700151003, 4089.8159582818694, 3491.685748282654, 3581.71346292296, 3621.619729928359, 4093.874184599244, 4124.876253712393, 3475.9224640361444, 3986.8604598839047, 4061.3704875744306, 4069.3895915612597, 4071.5114186297687, 3535.805530695811, 3943.033956680603, 4013.538443079054, 4030.9596904030877, 4040.838366465338, 3498.041096985696, 3537.451694987281, 3539.3629146753574, 3541.4687796830426, 3556.715462762973, 4246.596573325529, 4532.736429770593, 5265.709901074223, 5277.445868183824, 5373.086575282211, 4518.81924723014, 4520.819167233307, 4527.660425468071, 4549.954500454986, 4582.358469814229, 4959.628027897922, 4973.3286006389035, 5011.548960593527, 5380.784768609251, 5593.692346920918, 3789.450529673182, 3789.82349312477, 3798.0, 3855.51806024247, 3873.1285460771383, 5460.426655201187, 5591.2043978011, 5629.324481062217, 5710.457506536914, 5875.472377181921, 3757.342465068602, 3866.2654095721723, 3874.9225015500097, 3878.864239751595, 3916.6083391661177, 3615.5480564929385, 3723.3856413691437, 3835.983464381941, 3972.8609498667406, 4005.4792876926394, 4409.5149533551285, 4450.844220452269, 4451.554844515523, 4538.591526762607, 4623.4451865775645, 5387.272718183073, 5610.663360198401, 5658.773649054074, 5669.716514174274, 5678.517326027251, 1090.373035504588, 1124.9100071994221, 1174.6843535240414, 1230.194222784078, 1279.6608898641866, 770.5184259837602, 845.9492430454193, 855.8887344645157, 873.3100850328296, 874.2001069021774, 4326.610605045498, 4367.759773212504, 4821.783019764119, 4901.5588597026435, 4950.529699678525, 4847.80608775652, 5017.724025178651, 5102.9489705103215, 5384.892302153935, 5402.756875940592, 4518.367428560005, 4598.425196850394, 4670.743109129031, 4740.360051393087, 4970.111357684057, 2493.314338556875, 2584.625229341735, 2775.9306017349727, 2794.2455537004894, 2834.6173266609158, 5291.391489978701, 5387.973060134675, 5514.09017512106, 5557.305336832896, 5561.582881283839, 4704.764761761899, 4875.0, 5283.890383019532, 5527.917081243784, 5619.381867994517, 5197.480251974848, 5296.470352964673, 5554.888902221933, 5579.944200558105, 5610.671571297948, 5229.136902680543, 5374.167004114369, 5409.864753381197, 5421.132618780976, 5468.507834294933, 4865.659403841839, 5303.4696530346655, 5322.866928326823, 5342.702637865755, 5455.563554915677, 4708.905821883474, 5625.690587017753, 5656.878670498563, 5681.630694004876, 5703.344115426613, 3577.3918433865783, 3746.4567637692926, 3909.882703518899, 4203.558626344312, 4205.789710514523, 5494.560435165097, 5783.739731712168, 5800.419958004166, 5838.416158384128, 5956.463918247378, 5194.818181363634, 5541.919325731444, 5575.553955683617, 5624.634398764068, 5683.23276357703, 4774.594159496482, 4997.800527873357, 5426.755795989111, 5629.662220266797, 5667.291588551431, 4540.523245059353, 5139.631610219904, 5379.488948549882, 5502.074274004067, 5529.695866727368, 4663.57760882934, 4720.442254056222, 4772.236442169236, 5133.383993920754, 5569.888602227852, 4715.844618068595, 5257.790708137226, 5451.700156491431, 5469.179623056573, 5474.288342515607], "value": 4009.3465141389916, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [698.9510734248605, 732.4653003307585, 764.6559048428205, 823.5305875650879, 843.1947490146911, 14305.0, 14936.0, 14937.477188298399, 14951.775723364131, 14964.850351496481, 13786.448542058331, 13903.0, 13909.860901390983, 13925.582232533015, 13956.162630242192, 865.4331412924513, 874.82940826539, 887.1217494680252, 887.8401887660251, 888.5601627194516, 898.3666515106867, 898.7079199260266, 900.5407242306405, 900.9234215091725, 902.9503377314245, 922.9676961306355, 947.4315410753561, 947.6020071569923, 948.9193418559396, 952.8665986761858, 941.1341565759449, 941.7833898203418, 941.835178843703, 942.9057094290516, 943.4905151218334, 692.2281655953575, 695.6765104226508, 696.0637941968045, 696.7004188199072, 697.9267176946398, 14230.0, 14610.926945365312, 14633.195174265411, 15004.924975375163, 15375.384984600603, 13748.725025499534, 13894.930525347309, 13999.89058700077, 14021.228832414214, 14042.508512202025, 11092.389918554476, 11246.550137994553, 11254.662360129209, 11667.591634292843, 11799.882001179963, 3539.2213712983103, 3564.0733409313766, 3619.9819000904827, 3629.3104310181243, 3764.5106136202116, 91307.0, 100475.49762251215, 104662.4766876176, 104710.0, 105532.4723376386, 10554.683359499228, 10556.419396933243, 10644.680659580225, 10692.433815884131, 11088.33469991803, 21042.15831366728, 21464.78535214659, 21477.0, 21555.137794488044, 21608.891955540123, 7249.565026098451, 7303.0, 7377.81555461107, 7491.3632341251605, 7571.46999710015, 4002.3796311571173, 4065.97967010169, 4087.5708050654252, 4110.445089912823, 4178.415021896937, 3565.037439891215, 3595.658412450813, 3630.49173115764, 3658.926821463609, 3670.504481894963, 654.2672207127952, 658.9044588534731, 662.6686656671665, 677.7119724117231, 679.4530403025611, 647.3429469088878, 673.8483841135803, 683.6547543490506, 688.1707542411382, 714.6783947223666, 9745.275759725908, 9918.15695665862, 10054.645898565974, 10061.849072263922, 10066.647667331608, 687.556526040701, 693.2963042511855, 696.7596179318127, 699.5601775121618, 711.6370650968043, 4722.126406614787, 4804.975975120102, 4844.878878028077, 4898.804047838118, 4971.477994810565, 94248.0, 96041.0, 97164.51417743007, 97523.0, 98233.50883245538, 82264.58867705743, 82623.58688206521, 83087.0, 83896.58051709703, 85849.0, 74211.62894185494, 75167.0, 75730.0, 75769.6211518939, 76533.6173319141, 9592.376495527767, 9611.663591774255, 9628.18160456341, 9650.95174524123, 9663.516824158905, 49328.0, 50097.656250000524, 50590.399632063374, 51088.74455627698, 52392.47607524029, 50592.74703626458, 62319.753604926744, 66603.66698166478, 68586.314136858, 72827.27172728417, 11343.319400835977, 11476.254043487146, 11525.711857203636, 11825.645230643095, 11897.82153267719, 12785.16896401731, 12876.35618219104, 13079.803802943154, 13238.735225295633, 13244.80132798028, 11639.709007274885, 11699.766004679688, 12024.158308918291, 12413.44139513706, 12447.58110870628, 11650.0, 11924.701882453008, 12053.337066461429, 12428.067894907737, 12602.36988150607, 11891.643250702493, 11910.940445297718, 12093.939530302292, 12236.95985841178, 12312.692182695504, 9724.416535007922, 10071.19430445548, 10096.84854727165, 10211.540480678535, 10827.566897324019, 8196.385271104571, 8416.537090460084, 9007.864882026644, 9604.85592716096, 9658.7585310365], "value": 7303.916581555066, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1446.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 115.0, 112.0, 114.0, 114.0, 114.0, 115.0, 115.0, 115.0], "value": 114.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 103.0, 129.0, 169.0, 133.0, 108.0, 109.0, 103.0, 129.0, 110.0], "value": 123.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [206.0, 248.0, 189.0, 187.0, 179.0, 184.0, 184.0, 183.0, 185.0, 182.0], "value": 192.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 54.0, 55.0, 85.0, 81.0, 59.0, 58.0, 57.0, 72.0, 59.0], "value": 66.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 71.0, 87.0, 70.0, 68.0, 70.0, 85.0, 68.0, 69.0, 84.0], "value": 76.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 88.0, 84.0, 89.0, 85.0, 89.0, 85.0, 87.0, 84.0], "value": 86.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 93.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 86.0, 86.0, 89.0, 86.0, 86.0, 84.0, 85.0, 85.0], "value": 85.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 57.0, 58.0, 58.0, 59.0, 59.0, 59.0, 59.0, 58.0, 58.0], "value": 58.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 71.0, 76.0, 79.0, 73.0, 70.0, 71.0, 71.0, 72.0, 72.0], "value": 72.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 87.0, 88.0, 86.0, 85.0, 86.0, 86.0, 83.0, 90.0], "value": 86.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 148.0, 148.0, 140.0, 138.0, 142.0, 144.0, 142.0, 189.0, 164.0], "value": 150.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 173.0, 173.0, 172.0, 177.0, 171.0, 172.0, 173.0, 171.0, 173.0], "value": 173.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 67.0, 68.0, 65.0, 65.0, 67.0, 67.0, 66.0], "value": 66.4, "unit": "score"}]}]} 11:14:32 INFO - Return code: 0 11:14:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:14:32 ERROR - # TBPL SUCCESS # 11:14:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:14:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:14:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:14:32 INFO - 2017-02-03 11:14:32.129 screenresolution[1655:9554] starting screenresolution argv=screenresolution get 11:14:32 INFO - 2017-02-03 11:14:32.131 screenresolution[1655:9554] Display 0: 1600x1200x32@60 11:14:32 INFO - 2017-02-03 11:14:32.138 screenresolution[1656:9557] starting screenresolution argv=screenresolution list 11:14:32 INFO - Available Modes on Display 0 11:14:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:14:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:14:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:14:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:14:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:14:32 INFO - Intel Iris: 11:14:32 INFO - Chipset Model: Intel Iris 11:14:32 INFO - Type: GPU 11:14:32 INFO - Bus: Built-In 11:14:32 INFO - VRAM (Dynamic, Max): 1536 MB 11:14:32 INFO - Vendor: Intel (0x8086) 11:14:32 INFO - Device ID: 0x0a2e 11:14:32 INFO - Revision ID: 0x0009 11:14:32 INFO - Displays: 11:14:32 INFO - Display: 11:14:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:14:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:14:32 INFO - Display Serial Number: 1600x1200 60 11:14:32 INFO - Main Display: Yes 11:14:32 INFO - Mirror: Off 11:14:32 INFO - Online: Yes 11:14:32 INFO - Rotation: Supported 11:14:32 INFO - Return code: 0 11:14:32 INFO - Running post-action listener: _resource_record_post_action 11:14:32 INFO - [mozharness: 2017-02-03 19:14:32.381860Z] Finished run-tests step (success) 11:14:32 INFO - Running post-run listener: _resource_record_post_run 11:14:32 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 39384064; Write bytes: 552458240; Read time: 384; Write time: 1717 11:14:32 INFO - TinderboxPrint: CPU usage
54.1% 11:14:32 INFO - TinderboxPrint: I/O read bytes / time
39,384,064 / 384 11:14:32 INFO - TinderboxPrint: I/O write bytes / time
552,458,240 / 1,717 11:14:32 INFO - TinderboxPrint: CPU idle
2,207.8 (45.9%) 11:14:32 INFO - TinderboxPrint: CPU system
964.4 (20.1%) 11:14:32 INFO - TinderboxPrint: CPU user
1,637.5 (34.0%) 11:14:32 INFO - TinderboxPrint: Swap in / out
290,430,976 / 0 11:14:32 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 242065920; Write bytes: 234299392; Read time: 17419; Write time: 420 11:14:32 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 37327872; Write bytes: 298809344; Read time: 360; Write time: 1255 11:14:32 INFO - Running post-run listener: _upload_blobber_files 11:14:32 INFO - Blob upload gear active. 11:14:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:14:32 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:14:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:14:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:14:33 INFO - (blobuploader) - INFO - Open directory for files ... 11:14:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:14:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:14:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:14:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:14:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:14:34 INFO - (blobuploader) - INFO - Done attempting. 11:14:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:14:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:14:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:14:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:14:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:14:35 INFO - (blobuploader) - INFO - Done attempting. 11:14:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:14:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:14:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:14:36 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:14:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:14:36 INFO - (blobuploader) - INFO - Done attempting. 11:14:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:14:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:14:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:14:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:14:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:14:38 INFO - (blobuploader) - INFO - Done attempting. 11:14:38 INFO - (blobuploader) - INFO - Iteration through files over. 11:14:38 INFO - Return code: 0 11:14:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:14:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:14:38 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/748d1879d71269f7cc35dc255bc3b884a732e326fb23ef392a0aa302f14ffcdd00058cba747246c51ddb70e74e2b7ae34b5ec942d7a7f50f5bc104cb37d341c2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7689a4adc0c3cb94855b71f8fe3472ef20fadb36cac9c0a8c9dae34b26a05a99abea6978e7edde5a2a1a96ff4ab8d6de8a66f4e60a02b6d2454bdcdd2e0e20b7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/56e8617422f38231452a89d76a7fe9540c09fa4bc314f46514bcf5b24a159a7df6f596e1882baaf8d75ef519cb7b9fc3a06f56dbce933356f0c66495b8b936b7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b9ad13452d72d2fc765de53ec40bacafac0b31303a24ebd628a652c5d8b06422e2b2b31f6f49284191cd0ecf720a1f33a556244d204e8bdbe51e9fd5f6843c46"} 11:14:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:14:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:14:38 INFO - Contents: 11:14:38 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/748d1879d71269f7cc35dc255bc3b884a732e326fb23ef392a0aa302f14ffcdd00058cba747246c51ddb70e74e2b7ae34b5ec942d7a7f50f5bc104cb37d341c2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7689a4adc0c3cb94855b71f8fe3472ef20fadb36cac9c0a8c9dae34b26a05a99abea6978e7edde5a2a1a96ff4ab8d6de8a66f4e60a02b6d2454bdcdd2e0e20b7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/56e8617422f38231452a89d76a7fe9540c09fa4bc314f46514bcf5b24a159a7df6f596e1882baaf8d75ef519cb7b9fc3a06f56dbce933356f0c66495b8b936b7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b9ad13452d72d2fc765de53ec40bacafac0b31303a24ebd628a652c5d8b06422e2b2b31f6f49284191cd0ecf720a1f33a556244d204e8bdbe51e9fd5f6843c46"} 11:14:38 INFO - Running post-run listener: copy_logs_to_upload_dir 11:14:38 INFO - Copying logs to upload dir... 11:14:38 INFO - mkdir: /builds/slave/test/build/upload/logs 11:14:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.166933 ========= master_lag: 2.87 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2017-02-03 11:14:41.720753) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-03 11:14:41.729598) ========= 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.8JQk8pwnOO/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.CWwUEMB98p/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/748d1879d71269f7cc35dc255bc3b884a732e326fb23ef392a0aa302f14ffcdd00058cba747246c51ddb70e74e2b7ae34b5ec942d7a7f50f5bc104cb37d341c2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7689a4adc0c3cb94855b71f8fe3472ef20fadb36cac9c0a8c9dae34b26a05a99abea6978e7edde5a2a1a96ff4ab8d6de8a66f4e60a02b6d2454bdcdd2e0e20b7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/56e8617422f38231452a89d76a7fe9540c09fa4bc314f46514bcf5b24a159a7df6f596e1882baaf8d75ef519cb7b9fc3a06f56dbce933356f0c66495b8b936b7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b9ad13452d72d2fc765de53ec40bacafac0b31303a24ebd628a652c5d8b06422e2b2b31f6f49284191cd0ecf720a1f33a556244d204e8bdbe51e9fd5f6843c46"} build_url:https://queue.taskcluster.net/v1/task/PK0IxXuZTtKdOo-s_sGFZw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011735 build_url: 'https://queue.taskcluster.net/v1/task/PK0IxXuZTtKdOo-s_sGFZw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/748d1879d71269f7cc35dc255bc3b884a732e326fb23ef392a0aa302f14ffcdd00058cba747246c51ddb70e74e2b7ae34b5ec942d7a7f50f5bc104cb37d341c2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7689a4adc0c3cb94855b71f8fe3472ef20fadb36cac9c0a8c9dae34b26a05a99abea6978e7edde5a2a1a96ff4ab8d6de8a66f4e60a02b6d2454bdcdd2e0e20b7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/56e8617422f38231452a89d76a7fe9540c09fa4bc314f46514bcf5b24a159a7df6f596e1882baaf8d75ef519cb7b9fc3a06f56dbce933356f0c66495b8b936b7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b9ad13452d72d2fc765de53ec40bacafac0b31303a24ebd628a652c5d8b06422e2b2b31f6f49284191cd0ecf720a1f33a556244d204e8bdbe51e9fd5f6843c46"}' ========= master_lag: 0.83 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-03 11:14:42.567703) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 11:14:42.568020) ========= 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.8JQk8pwnOO/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.CWwUEMB98p/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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.005292 ========= master_lag: 0.03 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 11:14:42.601896) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-03 11:14:42.602163) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-03 11:14:42.602444) ========= ========= Total master_lag: 3.79 =========