builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0079 starttime: 1493577403.93 results: success (0) buildid: 20170430100946 builduid: 944abf04bbe2408ea2aa406a16adad4f revision: 4a587e53611752e69d79f6dddecada695234dbba ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-30 11:36:43.932728) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-30 11:36:43.933197) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-30 11:36:43.933493) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-30 11:36:44.274251) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-30 11:36:44.274581) ========= 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.xgGapgwaer/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.Eg1xMP1f58/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-04-30 11:36:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 55.3M=0s 2017-04-30 11:36:44 (55.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.169940 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-30 11:36:44.488436) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-30 11:36:44.488753) ========= 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.xgGapgwaer/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.Eg1xMP1f58/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.020955 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-30 11:36:44.557375) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-30 11:36:44.558011) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 4a587e53611752e69d79f6dddecada695234dbba --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 4a587e53611752e69d79f6dddecada695234dbba --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.xgGapgwaer/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.Eg1xMP1f58/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-04-30 11:36:44,651 truncating revision to first 12 chars 2017-04-30 11:36:44,651 Setting DEBUG logging. 2017-04-30 11:36:44,651 attempt 1/10 2017-04-30 11:36:44,651 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/4a587e536117?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-30 11:36:45,408 unpacking tar archive at: mozilla-beta-4a587e536117/testing/mozharness/ program finished with exit code 0 elapsedTime=1.012175 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-30 11:36:45.609486) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-30 11:36:45.609795) ========= script_repo_revision: 4a587e53611752e69d79f6dddecada695234dbba ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-30 11:36:45.610243) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-30 11:36:45.610521) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-30 11:36:45.647556) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2017-04-30 11:36:45.647901) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.xgGapgwaer/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.Eg1xMP1f58/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 11:36:45 INFO - MultiFileLogger online at 20170430 11:36:45 in /builds/slave/test 11:36:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 11:36:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:36:45 INFO - {'append_to_log': False, 11:36:45 INFO - 'base_work_dir': '/builds/slave/test', 11:36:45 INFO - 'blob_upload_branch': 'Mozilla-Beta', 11:36:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:36:45 INFO - 'branch': 'Mozilla-Beta', 11:36:45 INFO - 'buildbot_json_path': 'buildprops.json', 11:36:45 INFO - 'config_files': ('talos/mac_config.py',), 11:36:45 INFO - 'default_actions': ('clobber', 11:36:45 INFO - 'read-buildbot-config', 11:36:45 INFO - 'download-and-extract', 11:36:45 INFO - 'populate-webroot', 11:36:45 INFO - 'create-virtualenv', 11:36:45 INFO - 'install', 11:36:45 INFO - 'run-tests'), 11:36:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:36:45 INFO - 'download_minidump_stackwalk': True, 11:36:45 INFO - 'download_symbols': 'ondemand', 11:36:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:36:45 INFO - 'tooltool.py': '/tools/tooltool.py', 11:36:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:36:45 INFO - '/tools/misc-python/virtualenv.py')}, 11:36:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:36:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:36:45 INFO - 'gecko_profile': False, 11:36:45 INFO - 'gecko_profile_interval': 0, 11:36:45 INFO - 'installer_path': 'installer.exe', 11:36:45 INFO - 'log_level': 'info', 11:36:45 INFO - 'log_name': 'talos', 11:36:45 INFO - 'log_to_console': True, 11:36:45 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:36:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:36:45 INFO - 'opt_config_files': (), 11:36:45 INFO - 'pip_index': False, 11:36:45 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:36:45 INFO - 'cmd': ('bash', 11:36:45 INFO - '-c', 11:36:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:36:45 INFO - 'enabled': True, 11:36:45 INFO - 'halt_on_failure': False, 11:36:45 INFO - 'name': 'check_screen_resolution'},), 11:36:45 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:36:45 INFO - 'cmd': ('bash', 11:36:45 INFO - '-c', 11:36:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:36:45 INFO - 'enabled': True, 11:36:45 INFO - 'halt_on_failure': False, 11:36:45 INFO - 'name': 'check_screen_resolution'},), 11:36:45 INFO - 'run_cmd_checks_enabled': True, 11:36:45 INFO - 'suite': 'dromaeojs-e10s', 11:36:45 INFO - 'system_bits': '32', 11:36:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:36:45 INFO - 'title': 't-yosemite-r7-0079', 11:36:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:36:45 INFO - 'use_talos_json': True, 11:36:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:36:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:36:45 INFO - 'work_dir': 'build'} 11:36:45 INFO - [mozharness: 2017-04-30 18:36:45.867510Z] Running clobber step. 11:36:45 INFO - Running pre-action listener: _resource_record_pre_action 11:36:45 INFO - Running main action method: clobber 11:36:45 INFO - rmtree: /builds/slave/test/build 11:36:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:36:47 INFO - Running post-action listener: _resource_record_post_action 11:36:47 INFO - [mozharness: 2017-04-30 18:36:47.642432Z] Finished clobber step (success) 11:36:47 INFO - [mozharness: 2017-04-30 18:36:47.642591Z] Running read-buildbot-config step. 11:36:47 INFO - Running pre-action listener: _resource_record_pre_action 11:36:47 INFO - Running main action method: read_buildbot_config 11:36:47 INFO - Using buildbot properties: 11:36:47 INFO - { 11:36:47 INFO - "project": "", 11:36:47 INFO - "product": "firefox", 11:36:47 INFO - "script_repo_revision": "production", 11:36:47 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 11:36:47 INFO - "repository": "", 11:36:47 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 11:36:47 INFO - "buildid": "20170430100946", 11:36:47 INFO - "pgo_build": "False", 11:36:47 INFO - "basedir": "/builds/slave/test", 11:36:47 INFO - "buildnumber": 12, 11:36:47 INFO - "slavename": "t-yosemite-r7-0079", 11:36:47 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 11:36:47 INFO - "platform": "yosemite_r7", 11:36:47 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 11:36:47 INFO - "branch": "mozilla-beta", 11:36:47 INFO - "repo_path": "releases/mozilla-beta", 11:36:47 INFO - "revision": "4a587e53611752e69d79f6dddecada695234dbba", 11:36:47 INFO - "stage_platform": "macosx64", 11:36:47 INFO - "builduid": "944abf04bbe2408ea2aa406a16adad4f", 11:36:47 INFO - "slavebuilddir": "test" 11:36:47 INFO - } 11:36:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/VEZ5b-lFQx6VWvRdkrgAhw/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 11:36:47 INFO - Running post-action listener: _resource_record_post_action 11:36:47 INFO - [mozharness: 2017-04-30 18:36:47.645593Z] Finished read-buildbot-config step (success) 11:36:47 INFO - [mozharness: 2017-04-30 18:36:47.645723Z] Running download-and-extract step. 11:36:47 INFO - Running pre-action listener: _resource_record_pre_action 11:36:47 INFO - Running main action method: download_and_extract 11:36:47 INFO - mkdir: /builds/slave/test/build/tests 11:36:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:36:47 INFO - trying https://queue.taskcluster.net/v1/task/VEZ5b-lFQx6VWvRdkrgAhw/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 11:36:47 INFO - Downloading https://queue.taskcluster.net/v1/task/VEZ5b-lFQx6VWvRdkrgAhw/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 11:36:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VEZ5b-lFQx6VWvRdkrgAhw/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json'}, attempt #1 11:36:48 INFO - Downloaded 1165 bytes. 11:36:48 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 11:36:48 INFO - Using the following test package requirements: 11:36:48 INFO - {u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 11:36:48 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 11:36:48 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 11:36:48 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 11:36:48 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 11:36:48 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 11:36:48 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 11:36:48 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 11:36:48 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 11:36:48 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 11:36:48 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 11:36:48 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 11:36:48 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 11:36:48 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 11:36:48 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 11:36:48 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 11:36:48 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 11:36:48 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 11:36:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VEZ5b-lFQx6VWvRdkrgAhw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 11:36:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VEZ5b-lFQx6VWvRdkrgAhw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 11:36:48 INFO - Fetch https://queue.taskcluster.net/v1/task/VEZ5b-lFQx6VWvRdkrgAhw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 11:36:50 INFO - Expected file size: 51227188 11:36:50 INFO - Obtained file size: 51227188 11:37:06 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip', u'firefox-54.0.en-US.mac.talos.tests.zip'] for test suite category: talos 11:37:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VEZ5b-lFQx6VWvRdkrgAhw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 11:37:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VEZ5b-lFQx6VWvRdkrgAhw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 11:37:06 INFO - Fetch https://queue.taskcluster.net/v1/task/VEZ5b-lFQx6VWvRdkrgAhw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 11:37:08 INFO - Expected file size: 51227188 11:37:08 INFO - Obtained file size: 51227188 11:37:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VEZ5b-lFQx6VWvRdkrgAhw/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 11:37:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VEZ5b-lFQx6VWvRdkrgAhw/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 11:37:24 INFO - Fetch https://queue.taskcluster.net/v1/task/VEZ5b-lFQx6VWvRdkrgAhw/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 11:37:24 INFO - Expected file size: 14404449 11:37:24 INFO - Obtained file size: 14404449 11:37:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:37:25 INFO - trying https://queue.taskcluster.net/v1/task/VEZ5b-lFQx6VWvRdkrgAhw/artifacts/public/build/firefox-54.0.en-US.mac.dmg 11:37:25 INFO - Downloading https://queue.taskcluster.net/v1/task/VEZ5b-lFQx6VWvRdkrgAhw/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 11:37:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VEZ5b-lFQx6VWvRdkrgAhw/artifacts/public/build/firefox-54.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg'}, attempt #1 11:37:27 INFO - Downloaded 59540836 bytes. 11:37:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VEZ5b-lFQx6VWvRdkrgAhw/artifacts/public/build/firefox-54.0.en-US.mac.dmg 11:37:27 INFO - mkdir: /builds/slave/test/properties 11:37:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:37:27 INFO - Writing to file /builds/slave/test/properties/build_url 11:37:27 INFO - Contents: 11:37:27 INFO - build_url:https://queue.taskcluster.net/v1/task/VEZ5b-lFQx6VWvRdkrgAhw/artifacts/public/build/firefox-54.0.en-US.mac.dmg 11:37:27 INFO - Running post-action listener: _resource_record_post_action 11:37:27 INFO - Running post-action listener: set_extra_try_arguments 11:37:27 INFO - [mozharness: 2017-04-30 18:37:27.736052Z] Finished download-and-extract step (success) 11:37:27 INFO - [mozharness: 2017-04-30 18:37:27.736197Z] Running populate-webroot step. 11:37:27 INFO - Running pre-action listener: _resource_record_pre_action 11:37:27 INFO - Running main action method: populate_webroot 11:37:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:37:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:37:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:37:27 INFO - '--tppagecycles', 11:37:27 INFO - '7'], 11:37:27 INFO - 'tests': ['tsvgm']}}, 11:37:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:37:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:37:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:37:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:37:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:37:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:37:27 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 11:37:27 INFO - 'talos_options': ['--disable-e10s'], 11:37:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:37:27 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:37:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:37:27 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 11:37:27 INFO - 'talos_options': ['--disable-e10s'], 11:37:27 INFO - 'tests': ['damp', 'tps']}, 11:37:27 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:37:27 INFO - 'tests': ['damp', 'tps']}, 11:37:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:37:27 INFO - 'tests': ['dromaeo_dom']}, 11:37:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:37:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:37:27 INFO - 'tests': ['basic_compositor_video']}, 11:37:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:37:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:37:27 INFO - 'tests': ['a11yr', 11:37:27 INFO - 'ts_paint', 11:37:27 INFO - 'tpaint', 11:37:27 INFO - 'sessionrestore', 11:37:27 INFO - 'sessionrestore_no_auto_restore', 11:37:27 INFO - 'tabpaint']}, 11:37:27 INFO - 'other-e10s': {'tests': ['a11yr', 11:37:27 INFO - 'ts_paint', 11:37:27 INFO - 'tpaint', 11:37:27 INFO - 'sessionrestore', 11:37:27 INFO - 'sessionrestore_no_auto_restore', 11:37:27 INFO - 'tabpaint']}, 11:37:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:37:27 INFO - 'ts_paint', 11:37:27 INFO - 'tpaint', 11:37:27 INFO - 'sessionrestore', 11:37:27 INFO - 'sessionrestore_no_auto_restore', 11:37:27 INFO - 'tabpaint']}, 11:37:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:37:27 INFO - 'ts_paint', 11:37:27 INFO - 'tpaint', 11:37:27 INFO - 'sessionrestore', 11:37:27 INFO - 'sessionrestore_no_auto_restore', 11:37:27 INFO - 'tabpaint']}, 11:37:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:37:27 INFO - 'tests': ['a11yr', 11:37:27 INFO - 'ts_paint', 11:37:27 INFO - 'tpaint', 11:37:27 INFO - 'sessionrestore', 11:37:27 INFO - 'sessionrestore_no_auto_restore', 11:37:27 INFO - 'tabpaint']}, 11:37:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:37:27 INFO - 'tests': ['a11yr', 11:37:27 INFO - 'ts_paint', 11:37:27 INFO - 'tpaint', 11:37:27 INFO - 'sessionrestore', 11:37:27 INFO - 'sessionrestore_no_auto_restore', 11:37:27 INFO - 'tabpaint']}, 11:37:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:37:27 INFO - 'tests': ['tsvgx', 11:37:27 INFO - 'tsvgr_opacity', 11:37:27 INFO - 'tart', 11:37:27 INFO - 'tscrollx', 11:37:27 INFO - 'cart', 11:37:27 INFO - 'tsvg_static']}, 11:37:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:37:27 INFO - 'tsvgr_opacity', 11:37:27 INFO - 'tart', 11:37:27 INFO - 'tscrollx', 11:37:27 INFO - 'cart', 11:37:27 INFO - 'tsvg_static']}, 11:37:27 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 11:37:27 INFO - 'talos_options': ['--disable-e10s'], 11:37:27 INFO - 'tests': ['tp5o']}, 11:37:27 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:37:27 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 11:37:27 INFO - 'talos_options': ['--disable-e10s', 11:37:27 INFO - '--xperf_path', 11:37:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:37:27 INFO - 'tests': ['tp5n']}, 11:37:27 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:37:27 INFO - 'talos_options': ['--xperf_path', 11:37:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:37:27 INFO - 'tests': ['tp5n']}}, 11:37:27 INFO - 'talos.zip': {'path': '', 11:37:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:37:27 INFO - Running post-action listener: _resource_record_post_action 11:37:27 INFO - [mozharness: 2017-04-30 18:37:27.754967Z] Finished populate-webroot step (success) 11:37:27 INFO - [mozharness: 2017-04-30 18:37:27.755105Z] Running create-virtualenv step. 11:37:27 INFO - Running pre-action listener: _resource_record_pre_action 11:37:27 INFO - Running main action method: create_virtualenv 11:37:27 INFO - Creating virtualenv /builds/slave/test/build/venv 11:37:27 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:37:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:37:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:37:27 INFO - Using real prefix '/tools/python27' 11:37:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:37:28 INFO - Installing distribute.............................................................................................................................................................................................done. 11:37:31 INFO - Installing pip.................done. 11:37:31 INFO - Return code: 0 11:37:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:37:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:37:31 INFO - Reading from file tmpfile_stdout 11:37:31 INFO - Output received: 11:37:31 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 11:37:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:37:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:37:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:37:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1013dab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013dd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad4b46a7e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011b8d30>, '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 0x1010dfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1011adbe8>, '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.xgGapgwaer/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.Eg1xMP1f58/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 11:37:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:37:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:37:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xgGapgwaer/Render', 11:37:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:37:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:37:31 INFO - 'HOME': '/Users/cltbld', 11:37:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:37:31 INFO - 'LOGNAME': 'cltbld', 11:37:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:31 INFO - 'MOZ_NO_REMOTE': '1', 11:37:31 INFO - 'NO_EM_RESTART': '1', 11:37:31 INFO - 'PAGER': '/bin/cat', 11:37:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:37:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:37:31 INFO - 'PWD': '/builds/slave/test', 11:37:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:37:31 INFO - 'SHELL': '/bin/bash', 11:37:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Eg1xMP1f58/Listeners', 11:37:31 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 11:37:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:37:31 INFO - 'USER': 'cltbld', 11:37:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:37:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:37:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:31 INFO - 'XPC_FLAGS': '0x0', 11:37:31 INFO - 'XPC_SERVICE_NAME': '0', 11:37:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:37:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:31 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:37:31 INFO - Cleaning up... 11:37:32 INFO - Return code: 0 11:37:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:37:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:37:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:37:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:32 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 0x1013dab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013dd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad4b46a7e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011b8d30>, '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 0x1010dfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1011adbe8>, '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.xgGapgwaer/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.Eg1xMP1f58/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 11:37:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:37:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:37:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xgGapgwaer/Render', 11:37:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:37:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:37:32 INFO - 'HOME': '/Users/cltbld', 11:37:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:37:32 INFO - 'LOGNAME': 'cltbld', 11:37:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:32 INFO - 'MOZ_NO_REMOTE': '1', 11:37:32 INFO - 'NO_EM_RESTART': '1', 11:37:32 INFO - 'PAGER': '/bin/cat', 11:37:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:37:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:37:32 INFO - 'PWD': '/builds/slave/test', 11:37:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:37:32 INFO - 'SHELL': '/bin/bash', 11:37:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Eg1xMP1f58/Listeners', 11:37:32 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 11:37:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:37:32 INFO - 'USER': 'cltbld', 11:37:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:37:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:37:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:32 INFO - 'XPC_FLAGS': '0x0', 11:37:32 INFO - 'XPC_SERVICE_NAME': '0', 11:37:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:37:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:32 INFO - Downloading/unpacking psutil>=3.1.1 11:37:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:37:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:37:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:37:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:37:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:37:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:37:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:37:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:37:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:37:36 INFO - Installing collected packages: psutil 11:37:36 INFO - Running setup.py install for psutil 11:37:36 INFO - building 'psutil._psutil_osx' extension 11:37:36 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 11:37:36 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 11:37:36 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 11:37:36 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 11:37:36 INFO - building 'psutil._psutil_posix' extension 11:37:36 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 11:37:36 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:37:36 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:37:36 INFO - ^ 11:37:37 INFO - 1 warning generated. 11:37:37 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 11:37:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:37:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:37:37 INFO - Successfully installed psutil 11:37:37 INFO - Cleaning up... 11:37:37 INFO - Return code: 0 11:37:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:37:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:37:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:37:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1013dab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013dd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad4b46a7e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011b8d30>, '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 0x1010dfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1011adbe8>, '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.xgGapgwaer/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.Eg1xMP1f58/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 11:37:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:37:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:37:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xgGapgwaer/Render', 11:37:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:37:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:37:37 INFO - 'HOME': '/Users/cltbld', 11:37:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:37:37 INFO - 'LOGNAME': 'cltbld', 11:37:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:37 INFO - 'MOZ_NO_REMOTE': '1', 11:37:37 INFO - 'NO_EM_RESTART': '1', 11:37:37 INFO - 'PAGER': '/bin/cat', 11:37:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:37:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:37:37 INFO - 'PWD': '/builds/slave/test', 11:37:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:37:37 INFO - 'SHELL': '/bin/bash', 11:37:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Eg1xMP1f58/Listeners', 11:37:37 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 11:37:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:37:37 INFO - 'USER': 'cltbld', 11:37:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:37:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:37:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:37 INFO - 'XPC_FLAGS': '0x0', 11:37:37 INFO - 'XPC_SERVICE_NAME': '0', 11:37:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:37:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:37:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:37:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:37:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:37:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:37:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:37:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:37:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:37:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:37:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:37:40 INFO - Installing collected packages: mozsystemmonitor 11:37:40 INFO - Running setup.py install for mozsystemmonitor 11:37:40 INFO - Successfully installed mozsystemmonitor 11:37:40 INFO - Cleaning up... 11:37:40 INFO - Return code: 0 11:37:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:37:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:37:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:37:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:40 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 0x1013dab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013dd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad4b46a7e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011b8d30>, '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 0x1010dfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1011adbe8>, '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.xgGapgwaer/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.Eg1xMP1f58/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 11:37:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:37:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:37:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xgGapgwaer/Render', 11:37:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:37:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:37:40 INFO - 'HOME': '/Users/cltbld', 11:37:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:37:40 INFO - 'LOGNAME': 'cltbld', 11:37:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:40 INFO - 'MOZ_NO_REMOTE': '1', 11:37:40 INFO - 'NO_EM_RESTART': '1', 11:37:40 INFO - 'PAGER': '/bin/cat', 11:37:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:37:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:37:40 INFO - 'PWD': '/builds/slave/test', 11:37:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:37:40 INFO - 'SHELL': '/bin/bash', 11:37:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Eg1xMP1f58/Listeners', 11:37:40 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 11:37:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:37:40 INFO - 'USER': 'cltbld', 11:37:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:37:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:37:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:40 INFO - 'XPC_FLAGS': '0x0', 11:37:40 INFO - 'XPC_SERVICE_NAME': '0', 11:37:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:37:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:40 INFO - Downloading/unpacking jsonschema==2.5.1 11:37:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:37:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:37:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:37:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:37:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:37:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:37:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:37:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:37:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:37:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:37:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:37:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:37:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:37:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:37:43 INFO - Downloading functools32-3.2.3-2.tar.gz 11:37:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:37:43 INFO - warning: no files found matching '*.txt' 11:37:43 INFO - no previously-included directories found matching 'build' 11:37:43 INFO - no previously-included directories found matching 'dist' 11:37:43 INFO - no previously-included directories found matching '.git*' 11:37:43 INFO - Installing collected packages: jsonschema, functools32 11:37:43 INFO - Running setup.py install for functools32 11:37:43 INFO - warning: no files found matching '*.txt' 11:37:43 INFO - no previously-included directories found matching 'build' 11:37:43 INFO - no previously-included directories found matching 'dist' 11:37:43 INFO - no previously-included directories found matching '.git*' 11:37:43 INFO - Successfully installed jsonschema functools32 11:37:43 INFO - Cleaning up... 11:37:44 INFO - Return code: 0 11:37:44 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:37:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:37:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:37:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:44 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 0x1013dab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013dd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad4b46a7e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011b8d30>, '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 0x1010dfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1011adbe8>, '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.xgGapgwaer/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.Eg1xMP1f58/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 11:37:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:37:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:37:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xgGapgwaer/Render', 11:37:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:37:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:37:44 INFO - 'HOME': '/Users/cltbld', 11:37:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:37:44 INFO - 'LOGNAME': 'cltbld', 11:37:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:44 INFO - 'MOZ_NO_REMOTE': '1', 11:37:44 INFO - 'NO_EM_RESTART': '1', 11:37:44 INFO - 'PAGER': '/bin/cat', 11:37:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:37:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:37:44 INFO - 'PWD': '/builds/slave/test', 11:37:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:37:44 INFO - 'SHELL': '/bin/bash', 11:37:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Eg1xMP1f58/Listeners', 11:37:44 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 11:37:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:37:44 INFO - 'USER': 'cltbld', 11:37:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:37:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:37:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:44 INFO - 'XPC_FLAGS': '0x0', 11:37:44 INFO - 'XPC_SERVICE_NAME': '0', 11:37:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:37:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:44 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:37:44 INFO - Cleaning up... 11:37:44 INFO - Return code: 0 11:37:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:37:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:37:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:37:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:44 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 0x1013dab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013dd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad4b46a7e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011b8d30>, '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 0x1010dfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1011adbe8>, '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.xgGapgwaer/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.Eg1xMP1f58/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 11:37:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:37:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:37:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xgGapgwaer/Render', 11:37:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:37:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:37:44 INFO - 'HOME': '/Users/cltbld', 11:37:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:37:44 INFO - 'LOGNAME': 'cltbld', 11:37:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:44 INFO - 'MOZ_NO_REMOTE': '1', 11:37:44 INFO - 'NO_EM_RESTART': '1', 11:37:44 INFO - 'PAGER': '/bin/cat', 11:37:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:37:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:37:44 INFO - 'PWD': '/builds/slave/test', 11:37:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:37:44 INFO - 'SHELL': '/bin/bash', 11:37:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Eg1xMP1f58/Listeners', 11:37:44 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 11:37:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:37:44 INFO - 'USER': 'cltbld', 11:37:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:37:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:37:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:44 INFO - 'XPC_FLAGS': '0x0', 11:37:44 INFO - 'XPC_SERVICE_NAME': '0', 11:37:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:37:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:44 INFO - Downloading/unpacking blobuploader==1.2.4 11:37:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:37:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:37:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:37:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:37:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:37:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:37:47 INFO - Downloading blobuploader-1.2.4.tar.gz 11:37:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:37:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:37:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:37:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:37:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:37:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:37:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:37:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:37:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:37:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:37:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:37:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:37:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:37:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:37:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:37:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:37:48 INFO - Downloading docopt-0.6.1.tar.gz 11:37:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:37:48 INFO - Installing collected packages: blobuploader, requests, docopt 11:37:48 INFO - Running setup.py install for blobuploader 11:37:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:37:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:37:48 INFO - Running setup.py install for requests 11:37:49 INFO - Running setup.py install for docopt 11:37:49 INFO - Successfully installed blobuploader requests docopt 11:37:49 INFO - Cleaning up... 11:37:49 INFO - Return code: 0 11:37:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:37:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:37:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:37:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:49 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 0x1013dab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013dd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad4b46a7e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011b8d30>, '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 0x1010dfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1011adbe8>, '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.xgGapgwaer/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.Eg1xMP1f58/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 11:37:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:37:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:37:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xgGapgwaer/Render', 11:37:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:37:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:37:49 INFO - 'HOME': '/Users/cltbld', 11:37:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:37:49 INFO - 'LOGNAME': 'cltbld', 11:37:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:49 INFO - 'MOZ_NO_REMOTE': '1', 11:37:49 INFO - 'NO_EM_RESTART': '1', 11:37:49 INFO - 'PAGER': '/bin/cat', 11:37:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:37:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:37:49 INFO - 'PWD': '/builds/slave/test', 11:37:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:37:49 INFO - 'SHELL': '/bin/bash', 11:37:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Eg1xMP1f58/Listeners', 11:37:49 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 11:37:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:37:49 INFO - 'USER': 'cltbld', 11:37:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:37:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:37:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:49 INFO - 'XPC_FLAGS': '0x0', 11:37:49 INFO - 'XPC_SERVICE_NAME': '0', 11:37:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:37:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:37:49 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-bWE8Sg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:37:49 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-e2ivHO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:37:49 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-C4NigM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:37:49 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-knUITt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:37:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:37:50 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-_KyKQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:37:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:37:50 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-9a0YtJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:37:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:37:50 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-aot6Qw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:37:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:37:50 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-suToTl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:37:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:37:50 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-Ayndoy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:37:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:37:50 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-14adNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:37:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:37:50 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-ztaUsn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:37:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:37:50 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-vqv_CT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:37:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:37:50 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-AHJDhs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:37:51 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-3Rt036-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:37:51 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-phdjjS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:37:51 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-FLaLU7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:37:51 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-E067fr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:37:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:37:51 INFO - Running setup.py install for manifestparser 11:37:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:37:51 INFO - Running setup.py install for mozcrash 11:37:51 INFO - Running setup.py install for mozdebug 11:37:51 INFO - Running setup.py install for mozdevice 11:37:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:37:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:37:52 INFO - Running setup.py install for mozfile 11:37:52 INFO - Running setup.py install for mozhttpd 11:37:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:37:52 INFO - Running setup.py install for mozinfo 11:37:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:37:52 INFO - Running setup.py install for mozInstall 11:37:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:37:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:37:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:37:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:37:52 INFO - Running setup.py install for mozleak 11:37:52 INFO - Running setup.py install for mozlog 11:37:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:37:52 INFO - Running setup.py install for moznetwork 11:37:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:37:53 INFO - Running setup.py install for mozprocess 11:37:53 INFO - Running setup.py install for mozprofile 11:37:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:37:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:37:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:37:53 INFO - Running setup.py install for mozrunner 11:37:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:37:53 INFO - Running setup.py install for mozscreenshot 11:37:53 INFO - Running setup.py install for moztest 11:37:53 INFO - Running setup.py install for mozversion 11:37:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:37:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:37:54 INFO - Cleaning up... 11:37:54 INFO - Return code: 0 11:37:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:37:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:37:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:37:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:54 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 0x1013dab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013dd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad4b46a7e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011b8d30>, '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 0x1010dfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1011adbe8>, '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.xgGapgwaer/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.Eg1xMP1f58/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 11:37:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:37:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:37:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xgGapgwaer/Render', 11:37:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:37:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:37:54 INFO - 'HOME': '/Users/cltbld', 11:37:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:37:54 INFO - 'LOGNAME': 'cltbld', 11:37:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:54 INFO - 'MOZ_NO_REMOTE': '1', 11:37:54 INFO - 'NO_EM_RESTART': '1', 11:37:54 INFO - 'PAGER': '/bin/cat', 11:37:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:37:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:37:54 INFO - 'PWD': '/builds/slave/test', 11:37:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:37:54 INFO - 'SHELL': '/bin/bash', 11:37:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Eg1xMP1f58/Listeners', 11:37:54 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 11:37:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:37:54 INFO - 'USER': 'cltbld', 11:37:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:37:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:37:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:54 INFO - 'XPC_FLAGS': '0x0', 11:37:54 INFO - 'XPC_SERVICE_NAME': '0', 11:37:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:37:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:37:54 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-I7lZsp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:37:54 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:37:54 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-UF5qww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:37:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:37:54 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-flqoV1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:37:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:37:54 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-dNzXFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:37:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:37:54 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-l9W52j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:37:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:37:54 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-g03WrF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:37:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:37:54 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-1mvhiR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:37:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:37:55 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-b0LnTc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:37:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:37:55 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-32BlBy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:37:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:37:55 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-VdT3_K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:37:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:37:55 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-8jcWCt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:37:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:37:55 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-yvra93-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:37:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:37:55 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-koCs44-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:37:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:37:55 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-owub6s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:37:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:37:55 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-kz9dyD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:37:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:37:55 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-Teqyg5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:37:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:37:56 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-q856UP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:37:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:37:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:37:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:37:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:37:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:37:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:37:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:37:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:37:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:37:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:37:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:37:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:37:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:37:58 INFO - Downloading blessings-1.6.tar.gz 11:37:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:37:58 INFO - Installing collected packages: blessings 11:37:58 INFO - Running setup.py install for blessings 11:37:59 INFO - Successfully installed blessings 11:37:59 INFO - Cleaning up... 11:37:59 INFO - Return code: 0 11:37:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:37:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:37:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:37:59 INFO - Reading from file tmpfile_stdout 11:37:59 INFO - Current package versions: 11:37:59 INFO - blessings == 1.6 11:37:59 INFO - blobuploader == 1.2.4 11:37:59 INFO - docopt == 0.6.1 11:37:59 INFO - functools32 == 3.2.3-2 11:37:59 INFO - jsonschema == 2.5.1 11:37:59 INFO - manifestparser == 1.1 11:37:59 INFO - mozInstall == 1.12 11:37:59 INFO - mozcrash == 1.0 11:37:59 INFO - mozdebug == 0.1 11:37:59 INFO - mozdevice == 0.49 11:37:59 INFO - mozfile == 1.2 11:37:59 INFO - mozhttpd == 0.7 11:37:59 INFO - mozinfo == 0.9 11:37:59 INFO - mozleak == 0.1 11:37:59 INFO - mozlog == 3.4 11:37:59 INFO - moznetwork == 0.27 11:37:59 INFO - mozprocess == 0.25 11:37:59 INFO - mozprofile == 0.28 11:37:59 INFO - mozrunner == 6.13 11:37:59 INFO - mozscreenshot == 0.1 11:37:59 INFO - mozsystemmonitor == 0.3 11:37:59 INFO - moztest == 0.8 11:37:59 INFO - mozversion == 1.4 11:37:59 INFO - psutil == 3.1.1 11:37:59 INFO - requests == 1.2.3 11:37:59 INFO - wsgiref == 0.1.2 11:37:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:37:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:37:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:37:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:59 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 0x1013dab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013dd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad4b46a7e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011b8d30>, '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 0x1010dfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1011adbe8>, '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.xgGapgwaer/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.Eg1xMP1f58/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 11:37:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:37:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:37:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xgGapgwaer/Render', 11:37:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:37:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:37:59 INFO - 'HOME': '/Users/cltbld', 11:37:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:37:59 INFO - 'LOGNAME': 'cltbld', 11:37:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:59 INFO - 'MOZ_NO_REMOTE': '1', 11:37:59 INFO - 'NO_EM_RESTART': '1', 11:37:59 INFO - 'PAGER': '/bin/cat', 11:37:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:37:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:37:59 INFO - 'PWD': '/builds/slave/test', 11:37:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:37:59 INFO - 'SHELL': '/bin/bash', 11:37:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Eg1xMP1f58/Listeners', 11:37:59 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 11:37:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:37:59 INFO - 'USER': 'cltbld', 11:37:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:37:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:37:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:59 INFO - 'XPC_FLAGS': '0x0', 11:37:59 INFO - 'XPC_SERVICE_NAME': '0', 11:37:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:37:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:37:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:37:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:37:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:37:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:37:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:37:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:37:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:37:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:37:59 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:37:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:37:59 INFO - Cleaning up... 11:37:59 INFO - Return code: 0 11:37:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:37:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:37:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:37:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:37:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:37:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:37:59 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 0x1013dab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013dd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad4b46a7e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011b8d30>, '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 0x1010dfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1011adbe8>, '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.xgGapgwaer/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.Eg1xMP1f58/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 11:37:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:37:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:37:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xgGapgwaer/Render', 11:37:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:37:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:37:59 INFO - 'HOME': '/Users/cltbld', 11:37:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:37:59 INFO - 'LOGNAME': 'cltbld', 11:37:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:59 INFO - 'MOZ_NO_REMOTE': '1', 11:37:59 INFO - 'NO_EM_RESTART': '1', 11:37:59 INFO - 'PAGER': '/bin/cat', 11:37:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:37:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:37:59 INFO - 'PWD': '/builds/slave/test', 11:37:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:37:59 INFO - 'SHELL': '/bin/bash', 11:37:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Eg1xMP1f58/Listeners', 11:37:59 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 11:37:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:37:59 INFO - 'USER': 'cltbld', 11:37:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:37:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:37:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:59 INFO - 'XPC_FLAGS': '0x0', 11:37:59 INFO - 'XPC_SERVICE_NAME': '0', 11:37:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:37:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:37:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:37:59 INFO - Cleaning up... 11:37:59 INFO - Return code: 0 11:37:59 INFO - Running post-action listener: _resource_record_post_action 11:37:59 INFO - Running post-action listener: _start_resource_monitoring 11:37:59 INFO - Starting resource monitoring. 11:37:59 INFO - [mozharness: 2017-04-30 18:37:59.998691Z] Finished create-virtualenv step (success) 11:37:59 INFO - [mozharness: 2017-04-30 18:37:59.999672Z] Running install step. 11:37:59 INFO - Running pre-action listener: _resource_record_pre_action 11:37:59 INFO - Running main action method: install 11:38:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:38:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:38:00 INFO - Reading from file tmpfile_stdout 11:38:00 INFO - Detecting whether we're running mozinstall >=1.0... 11:38:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:38:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:38:00 INFO - Reading from file tmpfile_stdout 11:38:00 INFO - Output received: 11:38:00 INFO - Usage: mozinstall [options] installer 11:38:00 INFO - Options: 11:38:00 INFO - -h, --help show this help message and exit 11:38:00 INFO - -d DEST, --destination=DEST 11:38:00 INFO - Directory to install application into. [default: 11:38:00 INFO - "/builds/slave/test"] 11:38:00 INFO - --app=APP Application being installed. [default: firefox] 11:38:00 INFO - mkdir: /builds/slave/test/build/application 11:38:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:38:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0.en-US.mac.dmg --destination /builds/slave/test/build/application 11:38:15 INFO - Reading from file tmpfile_stdout 11:38:15 INFO - Output received: 11:38:15 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 11:38:15 INFO - Running post-action listener: _resource_record_post_action 11:38:15 INFO - [mozharness: 2017-04-30 18:38:15.106645Z] Finished install step (success) 11:38:15 INFO - [mozharness: 2017-04-30 18:38:15.106788Z] Running run-tests step. 11:38:15 INFO - Running pre-action listener: _resource_record_pre_action 11:38:15 INFO - Running main action method: run_tests 11:38:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:38:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:38:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:38:15 INFO - 2017-04-30 11:38:15.121 screenresolution[2452:35838] starting screenresolution argv=screenresolution get 11:38:15 INFO - 2017-04-30 11:38:15.124 screenresolution[2452:35838] Display 0: 1600x1200x32@60 11:38:15 INFO - 2017-04-30 11:38:15.130 screenresolution[2453:35840] starting screenresolution argv=screenresolution list 11:38:15 INFO - Available Modes on Display 0 11:38:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:38:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:38:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:38:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:38:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:38:15 INFO - Intel Iris: 11:38:15 INFO - Chipset Model: Intel Iris 11:38:15 INFO - Type: GPU 11:38:15 INFO - Bus: Built-In 11:38:15 INFO - VRAM (Dynamic, Max): 1536 MB 11:38:15 INFO - Vendor: Intel (0x8086) 11:38:15 INFO - Device ID: 0x0a2e 11:38:15 INFO - Revision ID: 0x0009 11:38:15 INFO - Displays: 11:38:15 INFO - Display: 11:38:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:38:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:38:15 INFO - Display Serial Number: 1600x1200 60 11:38:15 INFO - Main Display: Yes 11:38:15 INFO - Mirror: Off 11:38:15 INFO - Online: Yes 11:38:15 INFO - Rotation: Supported 11:38:15 INFO - Return code: 0 11:38:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:38:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:38:15 INFO - Python 2.7.3 11:38:15 INFO - Return code: 0 11:38:15 INFO - grabbing minidump binary from tooltool 11:38:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:38:15 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 0x1011b8d30>, '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 0x1010dfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1011adbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:38:15 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:38:15 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 11:38:15 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:38:15 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:38:15 INFO - Return code: 0 11:38:15 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:38:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:38:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:38:15 INFO - ENV: RUST_BACKTRACE is now 1 11:38:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:38:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:38:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VEZ5b-lFQx6VWvRdkrgAhw/artifacts/public/build/firefox-54.0.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-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:38:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VEZ5b-lFQx6VWvRdkrgAhw/artifacts/public/build/firefox-54.0.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-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:38:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xgGapgwaer/Render', 11:38:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:38:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:38:15 INFO - 'HOME': '/Users/cltbld', 11:38:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:38:15 INFO - 'LOGNAME': 'cltbld', 11:38:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:38:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:38:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:38:15 INFO - 'MOZ_NO_REMOTE': '1', 11:38:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:38:15 INFO - 'NO_EM_RESTART': '1', 11:38:15 INFO - 'PAGER': '/bin/cat', 11:38:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:38:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:38:15 INFO - 'PWD': '/builds/slave/test', 11:38:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:38:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:38:15 INFO - 'RUST_BACKTRACE': '1', 11:38:15 INFO - 'SHELL': '/bin/bash', 11:38:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Eg1xMP1f58/Listeners', 11:38:15 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 11:38:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:38:15 INFO - 'USER': 'cltbld', 11:38:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:38:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:38:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:38:15 INFO - 'XPC_FLAGS': '0x0', 11:38:15 INFO - 'XPC_SERVICE_NAME': '0', 11:38:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:38:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VEZ5b-lFQx6VWvRdkrgAhw/artifacts/public/build/firefox-54.0.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-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:38:15 INFO - mozversion application_buildid: 20170430100946 11:38:15 INFO - mozversion application_changeset: 4a587e53611752e69d79f6dddecada695234dbba 11:38:15 INFO - mozversion application_display_name: Firefox 11:38:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:38:15 INFO - mozversion application_name: Firefox 11:38:15 INFO - mozversion application_remotingname: firefox 11:38:15 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 11:38:15 INFO - mozversion application_vendor: Mozilla 11:38:15 INFO - mozversion application_version: 54.0 11:38:15 INFO - mozversion platform_buildid: 20170430100946 11:38:15 INFO - mozversion platform_changeset: 4a587e53611752e69d79f6dddecada695234dbba 11:38:15 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 11:38:15 INFO - mozversion platform_version: 54.0 11:38:15 INFO - using testdate: 1493577495 11:38:15 INFO - actual date: 1493577495 11:38:15 INFO - starting webserver on 'localhost:58734' 11:38:15 INFO - SUITE-START | Running 2 tests 11:38:15 INFO - TEST-START | dromaeo_css 11:38:15 INFO - operating with platform_type : mac_ 11:38:15 INFO - Initialising browser for dromaeo_css test... 11:38:15 INFO - TEST-INFO | started process 2463 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/tmpgCZwgr/profile http://localhost:58734/getInfo.html) 11:38:18 INFO - PROCESS | 2463 | 2017-04-30 11:38:18.626 plugin-container[2466:35988] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b3f, name = 'com.apple.tsm.portname' 11:38:18 INFO - PROCESS | 2463 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:38:18 INFO - PROCESS | 2463 | 2017-04-30 11:38:18.627 plugin-container[2466:35988] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x920f, name = 'com.apple.CFPasteboardClient' 11:38:18 INFO - PROCESS | 2463 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:38:18 INFO - PROCESS | 2463 | 2017-04-30 11:38:18.627 plugin-container[2466:35988] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:38:18 INFO - PROCESS | 2463 | __metrics Screen width/height:1600/1200 11:38:18 INFO - PROCESS | 2463 | colorDepth:24 11:38:18 INFO - PROCESS | 2463 | Browser inner width/height: 1024/689 11:38:18 INFO - PROCESS | 2463 | __metrics 11:38:18 ERROR - PROCESS | 2463 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3371: TypeError: this.tabs is undefined 11:38:19 INFO - TEST-INFO | 2463: exit 0 11:38:19 INFO - Browser initialized. 11:38:19 INFO - Running cycle 1/1 for dromaeo_css test... 11:38:19 INFO - TEST-INFO | started process 2467 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/tmpgCZwgr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:38:21 INFO - PROCESS | 2467 | 2017-04-30 11:38:21.814 plugin-container[2468:36126] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4347, name = 'com.apple.tsm.portname' 11:38:21 INFO - PROCESS | 2467 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:38:21 INFO - PROCESS | 2467 | 2017-04-30 11:38:21.815 plugin-container[2468:36126] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4617, name = 'com.apple.CFPasteboardClient' 11:38:21 INFO - PROCESS | 2467 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:38:21 INFO - PROCESS | 2467 | 2017-04-30 11:38:21.815 plugin-container[2468:36126] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:38:31 INFO - PROCESS | 2467 | RSS: Main: 174669824 11:38:31 INFO - PROCESS | 2467 | 11:41:33 INFO - PROCESS | 2467 | Cycle 1(1): loaded http://localhost:58734/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58734/tests/dromaeo/cssquery-ext.html) 11:41:35 INFO - PROCESS | 2467 | RSS: Main: 193564672 11:41:35 INFO - PROCESS | 2467 | 11:44:37 INFO - PROCESS | 2467 | Cycle 1(1): loaded http://localhost:58734/tests/dromaeo/cssquery-ext.html (next: http://localhost:58734/tests/dromaeo/cssquery-jquery.html) 11:44:38 INFO - PROCESS | 2467 | RSS: Main: 204861440 11:44:38 INFO - PROCESS | 2467 | 11:47:40 INFO - PROCESS | 2467 | Cycle 1(1): loaded http://localhost:58734/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58734/tests/dromaeo/cssquery-mootools.html) 11:47:41 INFO - PROCESS | 2467 | RSS: Main: 208850944 11:47:41 INFO - PROCESS | 2467 | 11:50:42 INFO - PROCESS | 2467 | Cycle 1(1): loaded http://localhost:58734/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58734/tests/dromaeo/cssquery-prototype.html) 11:50:43 INFO - PROCESS | 2467 | RSS: Main: 212496384 11:50:43 INFO - PROCESS | 2467 | 11:53:46 INFO - PROCESS | 2467 | Cycle 1(1): loaded http://localhost:58734/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58734/tests/dromaeo/cssquery-yui.html) 11:53:47 INFO - PROCESS | 2467 | RSS: Main: 215023616 11:53:47 INFO - PROCESS | 2467 | 11:56:49 INFO - PROCESS | 2467 | Cycle 1(1): loaded http://localhost:58734/tests/dromaeo/cssquery-yui.html (next: http://localhost:58734/tests/dromaeo/cssquery-dojo.html) 11:56:49 INFO - PROCESS | 2467 | RSS: Main: 212905984 11:56:49 INFO - PROCESS | 2467 | 11:56:49 INFO - PROCESS | 2467 | __start_tp_report 11:56:49 INFO - PROCESS | 2467 | _x_x_mozilla_page_load 11:56:49 INFO - PROCESS | 2467 | _x_x_mozilla_page_load_details 11:56:49 INFO - PROCESS | 2467 | |i|pagename|runs| 11:56:49 INFO - PROCESS | 2467 | |0;dojo.html;3511.84196711148;3522.9823850880744;3534.0634731796094;3542.1144713821545;3564.554430696163;5889.970550147254;5927.792527261541;5942.524598032158;5985;6016.639001659903;5989.640621562709;6020.939790602092;6030.517558595313;6033.245844269466;6085.4218849209365;5331.866703332418;5336.092864213074;5354.250404943311;5390.056740070472;5470.699111548864;5412.161115027177;5413;5421.403645598981;5423;5435.10320797068;5214.8696282592855;5233.842984710464;5394.02907476654;5431.755570999295;5450.264214331074;5359.196120581905;5383.138697808351;5437.972810135924;5486.945130548684;5507.311586051744;5310.946890531122;5372.650777699476;5372.865678358073;5389.083855744533;5409.999150157233;5199.558037566811;5680.091185410314;6058.606190597641;6105;6134.018557030854;6236.688165591748;6239.032949892774;6286.339934306878;6293.024581189923;6344.936550634527;6426.228852537679;6434.356564343575;6436.581622194542;6445.967770161119;6447.677616119176;5338.199270109515;6024.246969128859;6070.059140833089;6111.755529778803;6183.845403864894;6266.060090986297;6305.621662700252;6376.968115159488;6477.708503117276;6497.447716944018;6296.622202667854;6314.494840412756;6336.334684858116;6344.968275158594;6351.777687780906;6312.589681670676;6333.873322533524;6359.459445947054;6373.458256048195;6384.201974753156;6199.473044791243;6223.719932603044;6277.1525844010475;6366.395192456709;6374.521910856704;6278.0269058296035;6298.338674439209;6318.7472501100365;6320.178376810985;6332.873342533216;5111.412187598399;5111.821086261963;5117.5394214520875;5136.9743151284;5148.407933087743;4465.084657645175;4576.427946506687;4585.862424127282;4594.402727645384;4605.125026245069;5881.823545293648;5979.611325263844;6051.636901785907;6127;6142.508599312045;6340.239171299474;6342.080398342215;6411.807645770635;6415.454686351619;6417.262014868256;5888.205092312569;5954.702264886739;6118.908216376758;6158.507319414436;6231.345708700612;5543.750531226105;5659.094544872801;5675.5459563234845;5685.403032681592;5698.373178950312;6548.1814773153355;6600.207975043026;6603.603783772989;6609.438197753053;6614.536982411185;6239.220097487814;6240.719167637377;6318.6840657965995;6416.518761092843;6445.484361250995;6445.677716114082;6485.481161507162;6498.447631951337;6510.707018184098;6519.054737063194;6342.936570634234;6351.015592583157;6362.459190968634;6363.90454143179;6369.267534233622;6253.468455181361;6320.557560970872;6360.918643830468;6381.457576106083;6397.8720425592155;6219.0982307566055;6241.126242325987;6245.0632405139595;6310.021946598285;6331.430171284606;6258.217722784652;6274.1843560336865;6308.14839996613;6326.746930122928;6327.050942358683;5932.377100404396;6220.253569571681;6259.217597800275;6266.404691554295;6272.655003974825;6161.507079433724;6199.56603037783;6205.937940620716;6224.719887604978;6295.1186833842385;6211.596246243979;6256.092866534418;6264.436200741955;6266.937330626635;6277.811665650038 11:56:49 INFO - PROCESS | 2467 | |1;ext.html;759.5328872743264;830.3398797955625;854.95268296337;931.7856892914633;948.4972964328908;38889.41665875011;39985.60014399855;41632.37551436723;41655.958601035025;41729.79135104328;39528.22123004465;39590.406143907865;39714.60285397145;39790.602093979054;39811.80094099533;8312.54281014544;8431.325493960469;11253.887461125365;11525.308481491138;11716.765664686744;11349.546018159264;11409.31544107352;11465.656030319104;11486.540538378496;11495;10145.086942175203;11067.778644427106;11456.599019034335;11474.426278686075;11478.655640330762;11398.544058237661;11438.142139339541;11448.656540303804;11468.31190128595;11478.196526243166;11101.666949991513;11133.665990020312;11153.944230278878;11178.608748693838;11182.384968826711;35306.29387412263;35324.64675353239;35518.467222991676;35519.467207991904;35524.64475355265;3900.4734360861203;3911.6283953024417;3942.448057271984;4019.4975628046495;4149.211649786531;25798.355041123934;26048.34879128018;26113.955441782306;26244.606330904862;26401;3222.532732753761;3288.5724855768835;3311.2218628622254;3402.5406570112964;3428.297199074184;369821;372385;418229;423950;460882.6955865233;52332.69168270824;52593.7370313146;56230.156547651815;56261.437385626436;56797.58006049799;56885.43114568884;57136.42863571394;57411.13883291754;57468.71265643645;57636;15833.524994249961;15894.284757185724;15908.840911590967;15951.840481595036;16218.594535136715;13787.793183102262;13798.241096739575;13845.861541384456;13855.584332470042;13907.026508144332;13756.243406612732;13786.724265514633;13790.793138102936;13835.584932452042;13839.54684758086;6010.879782404415;6045.6070355426755;6052.818415447544;6059.848503787441;6061.939380606225;1167.3579531257774;1178.3165763856941;1183.8579370475427;1200.5557943560764;1213.4467881112191;24481.775911204368;28819.855900720362;29055.983040593477;29159.416811663647;29390.265243369086;1290.619267316144;1291.3994992328612;1304.8695130487065;1342.1142046249429;1349.6221058103747;14474.782878256834;14539.41842326295;14893.32980015902;14913.776293355608;15159;499330;501025;501882;503027;503785;59145.704271479226;59618;59635.80728385408;59787.40212597905;59810.401895981355;1474.6165996840684;1492.6193820575684;1539.122700060977;1548.7754275630195;1551.5965848879373;27074.458510829278;28394.432111357244;28464.57303140496;32542;33207.16982075467;58480.4151958492;62174;62296.06555901575;62304;62463.37536624575;501864;504468;507081;507692;510187;31198;38297;39430.802845985585;40733.38899916445;40779.7961010193;47222.52777472319;47429;47823.5217647833;48622.27066593933;49255.753721231165;32454.67545324611;32620.83689581537;33026.33947321088;33369;33808.830955845064;27690.44619107647;32685.836570816995;32863.50704739383;33522.82670106534;33684.66315336815;31966.68033319637;32733.508997365534;40153.79923100366;40366.59633403629;40622;25713.614295785952;32324.515132272565;32606.51090233601;33421.33157336888;33522.832385837915;22373.9931703077;25788;26223.4755304889;26482.602760958987;26970 11:56:49 INFO - PROCESS | 2467 | |2;jquery.html;410.15712710380166;418.8136279355688;438.2090326959837;440.10715652506707;444.6842741653424;20248.291309804143;21323.040463179157;22472.32583022508;22646.773532264673;22689.86550672466;22392.440188995282;22534;22593;22803.657945130835;24224.636630450514;6901.44788416928;6911.48163887708;7122.66592347812;7191.604461754601;7213.963930180368;6830.760923367683;6988.301169883021;7046.506744527859;7050.471214658921;7050.625128100022;6826.317368263183;6973.198082220559;6983.266756990519;7035.226125126232;7090;6702.765403210913;7047.119110111236;7052.576845389293;7083.574985500886;7126.536775109627;6825.1127353444235;6828.829279268058;6838.589684618939;6840.179178498612;6842.384185423336;27391.45217095667;27949.86025069882;28099.0165344214;28163.29591760202;28238;3556.5732112146447;3607.512985746917;3622.130688634735;3631.092226943264;3650.762700424464;16723.749143762852;17258.395956141474;17923.551911202194;17948.14583426304;18355.908220458947;1946.99026504868;2168.6530155175096;2169.262450766747;2201.438633148553;2205.933821985343;111377;129144.41711165819;133501.3324933379;137167.31416342955;138217.6178238215;20166.596668066555;22074.22740204085;23600.409989750395;23778.64332035021;24262.393440164138;31290.37419251602;37245.25509489849;37429.81285093611;38141.80929095392;38175.472981081;11411.429428528707;11554.94222528882;11608.419579021016;11691.590794322328;11940;9463.290253231035;9466.053394660617;9494.905050949541;9645.08371704687;9732.07545283197;8868.689595864114;9318.767030824149;9879.654212102541;11178.161637877192;11280.943595282135;3701.5188025556504;3925.495892557012;4329.913401732011;4427.933580996288;4482.686211965196;898.2723993565234;942.1850099663742;1050.417018554694;1054.9555939619875;1059.4067322299536;23286.65070023951;23335.41661458477;23347.7665223349;23422.882885585805;23552.76447235506;1041.9374837509774;1043.6451606453843;1047.8061558611528;1082.5345101606226;1084.9891501084887;11859.88140118605;12119;12267.202631828903;12276.693082672826;12334.81497777534;511931;640812;649394;689186;820173;116164;124325;156938;174469;177575;1323.9536616218386;1365.5797970110973;1386.6186798630256;1390.3534856291874;1394.28194479845;19119.13963871657;20398;20562.485937851674;20586.588268234253;20602.69095963592;66058.66970665116;67148.6642566784;67492.66253668896;68060.6596967012;69521.30478695148;96229.5188524053;96939.54590681287;97841;100764.49617751864;101561.98438015525;11812.81871812812;11911.821322679993;12089;12109.939450302692;12383.009359251058;12189.878101218874;13709.245991470167;13738.65653358674;13895;13980.720385592434;11683.357415342238;11707.590234342098;11867.643970680894;11998.100142489522;12142.028637708785;10939.617113400993;10986.560537578407;11027.503762330554;11141.986240889255;11341.716457088638;11768.52925882955;11834.289942603471;11932;11937.98527125204;12133.575324863587;10202.948985255027;11790.646280611596;11817.995470385114;12033.916947474769;12150.392480376122;10588.947055264982;11585.710357241136;11725.237859539102;11931.463084161407;12065.034797216025 11:56:49 INFO - PROCESS | 2467 | |3;mootools.html;1579.6682696633707;1619.295606411211;1632.469447429585;1643.6876993371259;1652.8264532224116;11084;11664.82502762457;11763.941180294098;11767.293962362264;11923.880761192386;11398.316101033945;11626.709332266697;11635.185537012412;11643.534258629667;11656.475458604362;2190.3538456155393;2448.1064411489765;2470.962935555968;2522.432452698147;2523.4322277487604;2445.1441995301593;2493.0401795308844;2518.798496120315;2531.5696331623576;2539.7206307306183;2474.9752502475017;2490.103562717429;2501.499700059986;2508.7742103210708;2510.184190138203;2453.141400509825;2457.987710061447;2468.049800826686;2473.319837044809;2499.7750202481684;2499.387650025755;2514.861682607456;2519.206449968254;2519.9748002519923;2527.0902475108946;9894;11389.886101139049;11541.249818761753;11588.942055289754;11626.76746465066;6025.367336429656;6157.0456579230295;6206.100115483275;6206.782762603287;6222.066689996492;3400.472926696366;3642.016655503026;3692.9630703692887;3696.2792255510185;3775.2826962876966;1143.3597185576104;1230.889219970207;1242.614789415275;1264.4183675509184;1304.3673818198167;14326.35531401079;14683.926580367137;15196.240187990667;15825.129617871013;16009.599760005976;4522.050369422393;4784.354112194878;4796.5203479651755;4833.419989601271;5020.548150666457;10167.28828981979;12195.817062744067;12228;12259.754804903852;12266.938665306616;6065.120557519135;6124.816255512342;6133.6013159145405;6134;6162.599431036968;5555.2500412444615;5561.610687251854;5573.916391254134;5653.321601407857;5734.483896449339;3471.2363280078343;3862.5944275851193;3988.66096381805;4026.959730402717;4052.5542190359038;1082.86464191976;1093.278436232083;1099.115212254127;1103.45379037377;1108.5842808946645;985.9260555458226;1003.5082809423476;1006.5124344147564;1012.488693209939;1021.8518314844455;6894.345037221456;6960.269171736996;7015.333543313377;7120.252373500812;7135.179454362711;1024.6618615856898;1025.3437799808128;1027.198784947742;1040.557762950743;1041.6458404142627;4220.303649897794;4317.6114149726045;4363.716358436692;4402.603765661106;4432.246518091933;13728.313584320744;14181.361838717075;14207.85792142086;14306.713865722835;14323.57029289123;13879.306034698224;14271.286435678174;14285.57143285703;14289.142651440947;14293.428262869369;8998.650202469551;10410.531526081344;10643.627473038407;10668.946655266674;10723.624673136403;6665.133532640726;6793.796186114425;6988.266232045562;7290.781276561712;7317.670704818403;11852.822207667065;11962.898366893982;11963.342016188844;12050.975667068398;12086.758264834478;12476.875231247934;12478.875211248134;12577.371131443208;12592.874071259537;12756.043296752596;8442.746717598482;8638.740837774876;8640.265577425738;8683.609237584451;8691.913080869363;8867.379283450096;10397;10470.162387008868;10691.786164276515;10853.511591978222;9084.818303634023;9187.08129187076;9266.629334826532;9436.858447123435;9458.810823783624;8998.55007249648;8999;9013.909860901307;9130.771730706785;9263.629454822001;7146;8394.916050839414;8475.957620211859;8487.448315859448;8492.065872753868;6099.2985806632805;6112.786052488142;6117.418845209698;6273.059041143865;6305.274893387135;6130.47890929276;6275.37246275387;6283.37166283368;6325.841853953688;6408.327125651739 11:56:49 INFO - PROCESS | 2467 | |4;prototype.html;392.9332013557695;396.0494812450119;396.21549332322;398.2457275700538;403.1694708899667;5012.29827824104;5046.0412521620865;5239.711815850127;5294.126469132593;5314.654547454413;4029.758214507124;4552.590266875981;4722.268048452487;4847.248676455146;5046.671966322187;3266.738660907122;4033.781420218875;4046.534648515429;4057.6753859691303;4060.3909413587903;3473.7742046767007;3639.4896118111083;3829.40644200148;4071.5774114401884;4072.8370865165357;4057.1539949323133;4058.5738497457783;4071.653909417703;4075.347944328893;4076.6331030207275;3054.6996327063894;3392.983035084821;3816.122291872857;4056.5721964939876;4121.433855135059;3607.2424790793966;3625.0393645683916;3626.9818650906577;3645.981770091159;3650.032741323525;4422.363725421583;4470.725843134724;4508.797104130322;4637.165310244155;4701.506341834092;4184.539700632928;4568.497465278817;4672.719636821767;4781.091592597395;4828.106800241966;5475.521609165543;5480.972595137038;5489.862753431156;5505.614606977513;5528.308961379827;3666.0651533858963;3954.8220330085214;4016.819243134066;4035.273650742865;4037.051292946155;5503.862403439946;5698.6865722385255;5782.56630752691;5787.50806181475;5799.652020878719;3635.437016903077;3894.279558281727;4079.7348172369293;4085.4280400743323;4101.015756218546;3679.889603311905;3998.7600743955454;4167.666106980101;4199.97900010498;4204.747715137101;4213.578642135762;4373.775342903992;4642.744649044335;4710.458297295786;4770.713757174581;5465.863353416117;5487.734797795305;5514.944850551524;5574.386817450078;5643.774249030075;1555.7121932442535;1604.8876578639617;1617.6360318928148;1704.4545745361613;1720.346268418018;1096.1231015187818;1168.6201984354948;1247.906407019459;1311.3902035553513;1379.9586012419643;4555.908881822411;5297.708626025606;5313;5330.493603107699;5365.973170134124;4804.237563401059;5121.743912804345;5230.8169214077325;5234.581233501311;5807.593468457252;4755.500672429345;4941.382327209099;5071.207708715302;5244.967886438115;5337.332833395825;2499.5875680512877;2594.9481010379686;2978.5554006306925;2991.685872983349;2999.5650630658433;5062.367204099488;5863.325717542537;5885.793997210163;5915.112733090071;5949.434803693643;5383.300170977748;5597.160425936061;5605.887882242332;5775.306963164448;6023.789167379121;5284.392294886137;5750.7987220447085;5784.587093614788;5944.286685597756;5950.166976623276;5162.328897243335;5346.866328341823;5542.644376140205;5710;5746.569007324551;5212.687238765686;5315.335583052119;5565.610407271614;5574.888502229852;5643.576731745054;5105.463926287686;5348.545373643284;5923.881522369615;6092.9086063709965;6093.238345206849;4143.56492568276;4470.329450582309;4567.3785806039705;4606.216943119611;4612.53874612536;4936.432310284364;5503.752331145028;5712.514436272963;5803.65178089316;5804.9709751452665;4376.452943382077;5126.384833819965;5490.325450737404;5499.9000199960965;5541.889162216814;4450.955490445054;4562.908741825211;5251.844594189272;5610.85972850682;5677.3754886963225;5221.616271688082;5387.272718182995;5414;5438.374586922555;5498.532624726943;4769.76151192432;4948.406191257072;4973.593088734228;5557.722113894209;5562.860928476659;4691.7184968901975;5338.866528336823;5470.589705772162;5506.779728810803;5549.361823390362 11:56:49 INFO - PROCESS | 2467 | |5;yui.html;750.6059318857602;770.1066762555437;798.7164556582413;881.8060026794107;888.0364804187458;15834.841651583482;17465.563360915985;17983.920964742123;18002.009889456076;18057;16260.186990650449;16324.428644997428;16595.66808663826;16687.749683754755;16715.164241787894;999.605155963394;1018.7707765752721;1023.2734758321601;1024.748936510556;1026.8921763214867;984.9753756156117;1018.9847152292684;1023.5649848814261;1024.933379330341;1027.4451796030173;1064.8562444070028;1066.983995240072;1068.6633710381243;1069.4225118436036;1069.7860427914409;1053.3837704942619;1056.7622284985816;1063.0857462582173;1064.2922456566373;1065.4566171252677;775.53467919248;782.0732432067961;788.0425283280784;789.4000559574707;793.4326956226269;16898.324067037305;17046.40337588191;17296.91351543234;17632.471025869243;17707.38024169148;12119.939400302943;13896.861031389759;13908.652283692887;14193.929030354782;14220.288985550682;12006.219595726338;12177.756444871053;12189.390530473442;12234.265944043385;12237.816432753516;3806.0675134591925;3867.7485963412287;3906.0625449892104;3942.9605703943166;4053.047533829548;95289;95544.04455955491;107550;114672.42663786712;118702.40648796788;11444.313341199555;11510.712232194095;11581.744450063048;11784.116191285688;11819.527218911318;23572.821358931986;23934.64098038531;24062.39844003914;24267.63598546023;24441.87779061093;7623.546294358567;7858.724944627025;8170.509769413854;8322.375821813388;8363.916360836314;4593.104344652761;4627.791749371219;4725.598324142417;4792.329073929653;4816.831410900601;3444.603870554868;3541.309444658267;3544.610092889832;3544.9822750886083;3561.554805649294;607.9787207447719;610.9450149486568;616.950643948483;631.43171145969;633.2084893882646;689.2074114768056;692.1728534401443;711.7081996381562;728.8884451211944;739.9593022383713;10792;10841.512131954081;11071.280366776135;11281;11347;692.3906961873519;718.741253148866;725.1117381208084;732.3957734868754;736.819479227582;5049.394072711299;5067.391912970467;5265.289185959923;5329.280547126166;5377.166539186433;100641.99358006327;109617;110481.44759276153;111501;111693.44153279181;59413;74025.88961165588;79349.60325198337;85819.57090214509;97726.51136744271;58752;66673;70035.64982175159;75020.24979750242;76078;8737.91262087371;10863.945680271549;11019.228653994143;11137.777244454903;11583.131265154978;48607;51263.487365125875;52839.73580132075;52972.47027529676;53764.73117634387;69384.95922561064;71448.64275678588;71504;72334.63832680802;73395;13519.391627376595;13621.659458513617;13659.9755018376;13699.972502062585;13816.101953372998;15498.302576384316;15602.492112939037;15759.763603546186;15949.760753588938;16090.919545402197;14433.278336083364;14487.92756036213;14584.979051466296;14781.852181478478;15313.234338283264;14260.215688137252;14629.195394253418;14689.045212061183;14694.63263418423;15233.466828660943;11818.940905295418;13872.929792644676;14484.493042743454;14547.927260363631;14631.85368146305;8948.032580015915;9999.20006399501;10365;10379.273450858367;10573.418461984666;10547.736306592396;10840;10918.727031824268;12096.879031209928;12336.691582710504 11:56:49 INFO - PROCESS | 2467 | __end_tp_report 11:56:49 INFO - PROCESS | 2467 | __start_cc_report 11:56:49 INFO - PROCESS | 2467 | _x_x_mozilla_cycle_collect,395 11:56:49 INFO - PROCESS | 2467 | __end_cc_report 11:56:49 INFO - PROCESS | 2467 | __startTimestamp1493578609919__endTimestamp 11:56:49 INFO - PROCESS | 2467 | 11:56:49 INFO - PROCESS | 2467 | ------- Summary: start ------- 11:56:49 INFO - PROCESS | 2467 | Number of tests: 6 11:56:49 INFO - PROCESS | 2467 | 11:56:49 INFO - PROCESS | 2467 | [#0] dojo.html Cycles:165 Average:5933.87 Median:6223.72 stddev:637.99 (10.3%) stddev-sans-first:611.00 11:56:49 INFO - PROCESS | 2467 | Values: 3511.8 3523.0 3534.1 3542.1 3564.6 5890.0 5927.8 5942.5 5985.0 6016.6 5989.6 6020.9 6030.5 6033.2 6085.4 5331.9 5336.1 5354.3 5390.1 5470.7 5412.2 5413.0 5421.4 5423.0 5435.1 5214.9 5233.8 5394.0 5431.8 5450.3 5359.2 5383.1 5438.0 5486.9 5507.3 5310.9 5372.7 5372.9 5389.1 5410.0 5199.6 5680.1 6058.6 6105.0 6134.0 6236.7 6239.0 6286.3 6293.0 6344.9 6426.2 6434.4 6436.6 6446.0 6447.7 5338.2 6024.2 6070.1 6111.8 6183.8 6266.1 6305.6 6377.0 6477.7 6497.4 6296.6 6314.5 6336.3 6345.0 6351.8 6312.6 6333.9 6359.5 6373.5 6384.2 6199.5 6223.7 6277.2 6366.4 6374.5 6278.0 6298.3 6318.7 6320.2 6332.9 5111.4 5111.8 5117.5 5137.0 5148.4 4465.1 4576.4 4585.9 4594.4 4605.1 5881.8 5979.6 6051.6 6127.0 6142.5 6340.2 6342.1 6411.8 6415.5 6417.3 5888.2 5954.7 6118.9 6158.5 6231.3 5543.8 5659.1 5675.5 5685.4 5698.4 6548.2 6600.2 6603.6 6609.4 6614.5 6239.2 6240.7 6318.7 6416.5 6445.5 6445.7 6485.5 6498.4 6510.7 6519.1 6342.9 6351.0 6362.5 6363.9 6369.3 6253.5 6320.6 6360.9 6381.5 6397.9 6219.1 6241.1 6245.1 6310.0 6331.4 6258.2 6274.2 6308.1 6326.7 6327.1 5932.4 6220.3 6259.2 6266.4 6272.7 6161.5 6199.6 6205.9 6224.7 6295.1 6211.6 6256.1 6264.4 6266.9 6277.8 11:56:49 INFO - PROCESS | 2467 | 11:56:49 INFO - PROCESS | 2467 | [#1] ext.html Cycles:180 Average:61893.82 Median:18168.78 stddev:126151.38 (694.3%) stddev-sans-first:126421.76 11:56:49 INFO - PROCESS | 2467 | Values: 759.5 830.3 855.0 931.8 948.5 38889.4 39985.6 41632.4 41656.0 41729.8 39528.2 39590.4 39714.6 39790.6 39811.8 8312.5 8431.3 11253.9 11525.3 11716.8 11349.5 11409.3 11465.7 11486.5 11495.0 10145.1 11067.8 11456.6 11474.4 11478.7 11398.5 11438.1 11448.7 11468.3 11478.2 11101.7 11133.7 11153.9 11178.6 11182.4 35306.3 35324.6 35518.5 35519.5 35524.6 3900.5 3911.6 3942.4 4019.5 4149.2 25798.4 26048.3 26114.0 26244.6 26401.0 3222.5 3288.6 3311.2 3402.5 3428.3 369821.0 372385.0 418229.0 423950.0 460882.7 52332.7 52593.7 56230.2 56261.4 56797.6 56885.4 57136.4 57411.1 57468.7 57636.0 15833.5 15894.3 15908.8 15951.8 16218.6 13787.8 13798.2 13845.9 13855.6 13907.0 13756.2 13786.7 13790.8 13835.6 13839.5 6010.9 6045.6 6052.8 6059.8 6061.9 1167.4 1178.3 1183.9 1200.6 1213.4 24481.8 28819.9 29056.0 29159.4 29390.3 1290.6 1291.4 1304.9 1342.1 1349.6 14474.8 14539.4 14893.3 14913.8 15159.0 499330.0 501025.0 501882.0 503027.0 503785.0 59145.7 59618.0 59635.8 59787.4 59810.4 1474.6 1492.6 1539.1 1548.8 1551.6 27074.5 28394.4 28464.6 32542.0 33207.2 58480.4 62174.0 62296.1 62304.0 62463.4 501864.0 504468.0 507081.0 507692.0 510187.0 31198.0 38297.0 39430.8 40733.4 40779.8 47222.5 47429.0 47823.5 48622.3 49255.8 32454.7 32620.8 33026.3 33369.0 33808.8 27690.4 32685.8 32863.5 33522.8 33684.7 31966.7 32733.5 40153.8 40366.6 40622.0 25713.6 32324.5 32606.5 33421.3 33522.8 22374.0 25788.0 26223.5 26482.6 26970.0 11:56:49 INFO - PROCESS | 2467 | 11:56:49 INFO - PROCESS | 2467 | [#2] jquery.html Cycles:180 Average:41040.27 Median:22233.33 stddev:111972.46 (503.6%) stddev-sans-first:112245.01 11:56:49 INFO - PROCESS | 2467 | Values: 410.2 418.8 438.2 440.1 444.7 20248.3 21323.0 22472.3 22646.8 22689.9 22392.4 22534.0 22593.0 22803.7 24224.6 6901.4 6911.5 7122.7 7191.6 7214.0 6830.8 6988.3 7046.5 7050.5 7050.6 6826.3 6973.2 6983.3 7035.2 7090.0 6702.8 7047.1 7052.6 7083.6 7126.5 6825.1 6828.8 6838.6 6840.2 6842.4 27391.5 27949.9 28099.0 28163.3 28238.0 3556.6 3607.5 3622.1 3631.1 3650.8 16723.7 17258.4 17923.6 17948.1 18355.9 1947.0 2168.7 2169.3 2201.4 2205.9 111377.0 129144.4 133501.3 137167.3 138217.6 20166.6 22074.2 23600.4 23778.6 24262.4 31290.4 37245.3 37429.8 38141.8 38175.5 11411.4 11554.9 11608.4 11691.6 11940.0 9463.3 9466.1 9494.9 9645.1 9732.1 8868.7 9318.8 9879.7 11178.2 11280.9 3701.5 3925.5 4329.9 4427.9 4482.7 898.3 942.2 1050.4 1055.0 1059.4 23286.7 23335.4 23347.8 23422.9 23552.8 1041.9 1043.6 1047.8 1082.5 1085.0 11859.9 12119.0 12267.2 12276.7 12334.8 511931.0 640812.0 649394.0 689186.0 820173.0 116164.0 124325.0 156938.0 174469.0 177575.0 1324.0 1365.6 1386.6 1390.4 1394.3 19119.1 20398.0 20562.5 20586.6 20602.7 66058.7 67148.7 67492.7 68060.7 69521.3 96229.5 96939.5 97841.0 100764.5 101562.0 11812.8 11911.8 12089.0 12109.9 12383.0 12189.9 13709.2 13738.7 13895.0 13980.7 11683.4 11707.6 11867.6 11998.1 12142.0 10939.6 10986.6 11027.5 11142.0 11341.7 11768.5 11834.3 11932.0 11938.0 12133.6 10202.9 11790.6 11818.0 12033.9 12150.4 10588.9 11585.7 11725.2 11931.5 12065.0 11:56:49 INFO - PROCESS | 2467 | 11:56:49 INFO - PROCESS | 2467 | [#3] mootools.html Cycles:180 Average:6933.40 Median:2509.48 stddev:4280.46 (170.6%) stddev-sans-first:4273.56 11:56:49 INFO - PROCESS | 2467 | Values: 1579.7 1619.3 1632.5 1643.7 1652.8 11084.0 11664.8 11763.9 11767.3 11923.9 11398.3 11626.7 11635.2 11643.5 11656.5 2190.4 2448.1 2471.0 2522.4 2523.4 2445.1 2493.0 2518.8 2531.6 2539.7 2475.0 2490.1 2501.5 2508.8 2510.2 2453.1 2458.0 2468.0 2473.3 2499.8 2499.4 2514.9 2519.2 2520.0 2527.1 9894.0 11389.9 11541.2 11588.9 11626.8 6025.4 6157.0 6206.1 6206.8 6222.1 3400.5 3642.0 3693.0 3696.3 3775.3 1143.4 1230.9 1242.6 1264.4 1304.4 14326.4 14683.9 15196.2 15825.1 16009.6 4522.1 4784.4 4796.5 4833.4 5020.5 10167.3 12195.8 12228.0 12259.8 12266.9 6065.1 6124.8 6133.6 6134.0 6162.6 5555.3 5561.6 5573.9 5653.3 5734.5 3471.2 3862.6 3988.7 4027.0 4052.6 1082.9 1093.3 1099.1 1103.5 1108.6 985.9 1003.5 1006.5 1012.5 1021.9 6894.3 6960.3 7015.3 7120.3 7135.2 1024.7 1025.3 1027.2 1040.6 1041.6 4220.3 4317.6 4363.7 4402.6 4432.2 13728.3 14181.4 14207.9 14306.7 14323.6 13879.3 14271.3 14285.6 14289.1 14293.4 8998.7 10410.5 10643.6 10668.9 10723.6 6665.1 6793.8 6988.3 7290.8 7317.7 11852.8 11962.9 11963.3 12051.0 12086.8 12476.9 12478.9 12577.4 12592.9 12756.0 8442.7 8638.7 8640.3 8683.6 8691.9 8867.4 10397.0 10470.2 10691.8 10853.5 9084.8 9187.1 9266.6 9436.9 9458.8 8998.6 8999.0 9013.9 9130.8 9263.6 7146.0 8394.9 8476.0 8487.4 8492.1 6099.3 6112.8 6117.4 6273.1 6305.3 6130.5 6275.4 6283.4 6325.8 6408.3 11:56:49 INFO - PROCESS | 2467 | 11:56:49 INFO - PROCESS | 2467 | [#4] prototype.html Cycles:180 Average:4526.04 Median:4837.68 stddev:1305.88 (27.0%) stddev-sans-first:1272.16 11:56:49 INFO - PROCESS | 2467 | Values: 392.9 396.0 396.2 398.2 403.2 5012.3 5046.0 5239.7 5294.1 5314.7 4029.8 4552.6 4722.3 4847.2 5046.7 3266.7 4033.8 4046.5 4057.7 4060.4 3473.8 3639.5 3829.4 4071.6 4072.8 4057.2 4058.6 4071.7 4075.3 4076.6 3054.7 3393.0 3816.1 4056.6 4121.4 3607.2 3625.0 3627.0 3646.0 3650.0 4422.4 4470.7 4508.8 4637.2 4701.5 4184.5 4568.5 4672.7 4781.1 4828.1 5475.5 5481.0 5489.9 5505.6 5528.3 3666.1 3954.8 4016.8 4035.3 4037.1 5503.9 5698.7 5782.6 5787.5 5799.7 3635.4 3894.3 4079.7 4085.4 4101.0 3679.9 3998.8 4167.7 4200.0 4204.7 4213.6 4373.8 4642.7 4710.5 4770.7 5465.9 5487.7 5514.9 5574.4 5643.8 1555.7 1604.9 1617.6 1704.5 1720.3 1096.1 1168.6 1247.9 1311.4 1380.0 4555.9 5297.7 5313.0 5330.5 5366.0 4804.2 5121.7 5230.8 5234.6 5807.6 4755.5 4941.4 5071.2 5245.0 5337.3 2499.6 2594.9 2978.6 2991.7 2999.6 5062.4 5863.3 5885.8 5915.1 5949.4 5383.3 5597.2 5605.9 5775.3 6023.8 5284.4 5750.8 5784.6 5944.3 5950.2 5162.3 5346.9 5542.6 5710.0 5746.6 5212.7 5315.3 5565.6 5574.9 5643.6 5105.5 5348.5 5923.9 6092.9 6093.2 4143.6 4470.3 4567.4 4606.2 4612.5 4936.4 5503.8 5712.5 5803.7 5805.0 4376.5 5126.4 5490.3 5499.9 5541.9 4451.0 4562.9 5251.8 5610.9 5677.4 5221.6 5387.3 5414.0 5438.4 5498.5 4769.8 4948.4 4973.6 5557.7 5562.9 4691.7 5338.9 5470.6 5506.8 5549.4 11:56:49 INFO - PROCESS | 2467 | 11:56:49 INFO - PROCESS | 2467 | [#5] yui.html Cycles:180 Average:20810.41 Median:17171.66 stddev:29133.78 (169.7%) stddev-sans-first:29176.57 11:56:49 INFO - PROCESS | 2467 | Values: 750.6 770.1 798.7 881.8 888.0 15834.8 17465.6 17983.9 18002.0 18057.0 16260.2 16324.4 16595.7 16687.7 16715.2 999.6 1018.8 1023.3 1024.7 1026.9 985.0 1019.0 1023.6 1024.9 1027.4 1064.9 1067.0 1068.7 1069.4 1069.8 1053.4 1056.8 1063.1 1064.3 1065.5 775.5 782.1 788.0 789.4 793.4 16898.3 17046.4 17296.9 17632.5 17707.4 12119.9 13896.9 13908.7 14193.9 14220.3 12006.2 12177.8 12189.4 12234.3 12237.8 3806.1 3867.7 3906.1 3943.0 4053.0 95289.0 95544.0 107550.0 114672.4 118702.4 11444.3 11510.7 11581.7 11784.1 11819.5 23572.8 23934.6 24062.4 24267.6 24441.9 7623.5 7858.7 8170.5 8322.4 8363.9 4593.1 4627.8 4725.6 4792.3 4816.8 3444.6 3541.3 3544.6 3545.0 3561.6 608.0 610.9 617.0 631.4 633.2 689.2 692.2 711.7 728.9 740.0 10792.0 10841.5 11071.3 11281.0 11347.0 692.4 718.7 725.1 732.4 736.8 5049.4 5067.4 5265.3 5329.3 5377.2 100642.0 109617.0 110481.4 111501.0 111693.4 59413.0 74025.9 79349.6 85819.6 97726.5 58752.0 66673.0 70035.6 75020.2 76078.0 8737.9 10863.9 11019.2 11137.8 11583.1 48607.0 51263.5 52839.7 52972.5 53764.7 69385.0 71448.6 71504.0 72334.6 73395.0 13519.4 13621.7 13660.0 13700.0 13816.1 15498.3 15602.5 15759.8 15949.8 16090.9 14433.3 14487.9 14585.0 14781.9 15313.2 14260.2 14629.2 14689.0 14694.6 15233.5 11818.9 13872.9 14484.5 14547.9 14631.9 8948.0 9999.2 10365.0 10379.3 10573.4 10547.7 10840.0 10918.7 12096.9 12336.7 11:56:49 INFO - PROCESS | 2467 | -------- Summary: end -------- 11:56:49 INFO - PROCESS | 2467 | 11:56:50 INFO - TEST-INFO | 2467: exit 0 11:56:50 INFO - TEST-OK | dromaeo_css | took 1114893ms 11:56:50 INFO - TEST-START | kraken 11:56:50 INFO - operating with platform_type : mac_ 11:56:50 INFO - Initialising browser for kraken test... 11:56:50 INFO - TEST-INFO | started process 2472 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/tmpdmBc0a/profile http://localhost:58734/getInfo.html) 11:56:53 INFO - PROCESS | 2472 | 2017-04-30 11:56:53.339 plugin-container[2474:38354] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x843f, name = 'com.apple.tsm.portname' 11:56:53 INFO - PROCESS | 2472 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:56:53 INFO - PROCESS | 2472 | 2017-04-30 11:56:53.340 plugin-container[2474:38354] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x434f, name = 'com.apple.CFPasteboardClient' 11:56:53 INFO - PROCESS | 2472 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:56:53 INFO - PROCESS | 2472 | 2017-04-30 11:56:53.340 plugin-container[2474:38354] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:56:53 INFO - PROCESS | 2472 | __metrics Screen width/height:1600/1200 11:56:53 INFO - PROCESS | 2472 | colorDepth:24 11:56:53 INFO - PROCESS | 2472 | Browser inner width/height: 1024/689 11:56:53 INFO - PROCESS | 2472 | __metrics 11:56:53 ERROR - PROCESS | 2472 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3371: TypeError: this.tabs is undefined 11:56:54 INFO - TEST-INFO | 2472: exit 0 11:56:54 INFO - Browser initialized. 11:56:54 INFO - Running cycle 1/1 for kraken test... 11:56:54 INFO - TEST-INFO | started process 2475 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/tmpdmBc0a/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:56:56 INFO - PROCESS | 2475 | 2017-04-30 11:56:56.508 plugin-container[2476:38478] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4643, name = 'com.apple.tsm.portname' 11:56:56 INFO - PROCESS | 2475 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:56:56 INFO - PROCESS | 2475 | 2017-04-30 11:56:56.508 plugin-container[2476:38478] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x470b, name = 'com.apple.CFPasteboardClient' 11:56:56 INFO - PROCESS | 2475 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:56:56 INFO - PROCESS | 2475 | 2017-04-30 11:56:56.508 plugin-container[2476:38478] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:57:06 INFO - PROCESS | 2475 | RSS: Main: 174661632 11:57:06 INFO - PROCESS | 2475 | 11:57:09 INFO - PROCESS | 2475 | Cycle 1(1): loaded http://localhost:58734/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58734/tests/kraken/driver.html?testName=audio-beat-detection) 11:57:10 INFO - PROCESS | 2475 | RSS: Main: 188370944 11:57:10 INFO - PROCESS | 2475 | 11:57:12 INFO - PROCESS | 2475 | Cycle 1(1): loaded http://localhost:58734/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58734/tests/kraken/driver.html?testName=audio-dft) 11:57:13 INFO - PROCESS | 2475 | RSS: Main: 196317184 11:57:13 INFO - PROCESS | 2475 | 11:57:16 INFO - PROCESS | 2475 | Cycle 1(1): loaded http://localhost:58734/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58734/tests/kraken/driver.html?testName=audio-fft) 11:57:17 INFO - PROCESS | 2475 | RSS: Main: 200044544 11:57:17 INFO - PROCESS | 2475 | 11:57:19 INFO - PROCESS | 2475 | Cycle 1(1): loaded http://localhost:58734/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58734/tests/kraken/driver.html?testName=audio-oscillator) 11:57:20 INFO - PROCESS | 2475 | RSS: Main: 201355264 11:57:20 INFO - PROCESS | 2475 | 11:57:22 INFO - PROCESS | 2475 | Cycle 1(1): loaded http://localhost:58734/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58734/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:57:22 INFO - PROCESS | 2475 | RSS: Main: 201375744 11:57:22 INFO - PROCESS | 2475 | 11:57:25 INFO - PROCESS | 2475 | Cycle 1(1): loaded http://localhost:58734/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58734/tests/kraken/driver.html?testName=imaging-darkroom) 11:57:26 INFO - PROCESS | 2475 | RSS: Main: 205258752 11:57:26 INFO - PROCESS | 2475 | 11:57:29 INFO - PROCESS | 2475 | Cycle 1(1): loaded http://localhost:58734/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58734/tests/kraken/driver.html?testName=imaging-desaturate) 11:57:30 INFO - PROCESS | 2475 | RSS: Main: 204976128 11:57:30 INFO - PROCESS | 2475 | 11:57:33 INFO - PROCESS | 2475 | Cycle 1(1): loaded http://localhost:58734/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58734/tests/kraken/driver.html?testName=json-parse-financial) 11:57:33 INFO - PROCESS | 2475 | RSS: Main: 205320192 11:57:33 INFO - PROCESS | 2475 | 11:57:35 INFO - PROCESS | 2475 | Cycle 1(1): loaded http://localhost:58734/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58734/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:57:36 INFO - PROCESS | 2475 | RSS: Main: 204804096 11:57:36 INFO - PROCESS | 2475 | 11:57:37 INFO - PROCESS | 2475 | Cycle 1(1): loaded http://localhost:58734/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58734/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:57:38 INFO - PROCESS | 2475 | RSS: Main: 204804096 11:57:38 INFO - PROCESS | 2475 | 11:57:40 INFO - PROCESS | 2475 | Cycle 1(1): loaded http://localhost:58734/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58734/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:57:41 INFO - PROCESS | 2475 | RSS: Main: 205185024 11:57:41 INFO - PROCESS | 2475 | 11:57:44 INFO - PROCESS | 2475 | Cycle 1(1): loaded http://localhost:58734/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58734/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:57:45 INFO - PROCESS | 2475 | RSS: Main: 205574144 11:57:45 INFO - PROCESS | 2475 | 11:57:47 INFO - PROCESS | 2475 | Cycle 1(1): loaded http://localhost:58734/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58734/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:57:48 INFO - PROCESS | 2475 | RSS: Main: 205295616 11:57:48 INFO - PROCESS | 2475 | 11:57:50 INFO - PROCESS | 2475 | Cycle 1(1): loaded http://localhost:58734/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58734/tests/kraken/driver.html?testName=ai-astar) 11:57:50 INFO - PROCESS | 2475 | RSS: Main: 207003648 11:57:50 INFO - PROCESS | 2475 | 11:57:50 INFO - PROCESS | 2475 | __start_tp_report 11:57:50 INFO - PROCESS | 2475 | _x_x_mozilla_page_load 11:57:50 INFO - PROCESS | 2475 | _x_x_mozilla_page_load_details 11:57:50 INFO - PROCESS | 2475 | |i|pagename|runs| 11:57:50 INFO - PROCESS | 2475 | |0;ai-astar;107;98;177;177;178;121;123;115;120;122 11:57:50 INFO - PROCESS | 2475 | |1;audio-beat-detection;145;112;108;144;124;108;113;111;136;143 11:57:50 INFO - PROCESS | 2475 | |2;audio-dft;198;220;288;244;197;201;197;199;197;196 11:57:50 INFO - PROCESS | 2475 | |3;audio-fft;86;58;60;87;62;63;68;60;74;62 11:57:50 INFO - PROCESS | 2475 | |4;audio-oscillator;86;70;87;73;72;71;82;72;68;92 11:57:50 INFO - PROCESS | 2475 | |5;imaging-gaussian-blur;90;90;88;88;90;110;87;89;88;89 11:57:50 INFO - PROCESS | 2475 | |6;imaging-darkroom;152;152;98;96;118;96;97;128;145;97 11:57:50 INFO - PROCESS | 2475 | |7;imaging-desaturate;98;94;90;82;148;147;103;90;92;117 11:57:50 INFO - PROCESS | 2475 | |8;json-parse-financial;67;65;63;66;68;68;67;68;68;69 11:57:50 INFO - PROCESS | 2475 | |9;json-stringify-tinderbox;59;65;69;74;57;59;58;58;72;87 11:57:50 INFO - PROCESS | 2475 | |10;stanford-crypto-aes;80;101;73;92;100;101;100;82;84;81 11:57:50 INFO - PROCESS | 2475 | |11;stanford-crypto-ccm;136;134;170;143;141;166;147;152;198;177 11:57:50 INFO - PROCESS | 2475 | |12;stanford-crypto-pbkdf2;166;169;165;161;171;168;164;166;163;178 11:57:50 INFO - PROCESS | 2475 | |13;stanford-crypto-sha256-iterative;63;67;63;64;67;66;63;66;74;79 11:57:50 INFO - PROCESS | 2475 | __end_tp_report 11:57:50 INFO - PROCESS | 2475 | __start_cc_report 11:57:50 INFO - PROCESS | 2475 | _x_x_mozilla_cycle_collect,987 11:57:50 INFO - PROCESS | 2475 | __end_cc_report 11:57:50 INFO - PROCESS | 2475 | __startTimestamp1493578670578__endTimestamp 11:57:50 INFO - PROCESS | 2475 | 11:57:50 INFO - PROCESS | 2475 | ------- Summary: start ------- 11:57:50 INFO - PROCESS | 2475 | Number of tests: 14 11:57:50 INFO - PROCESS | 2475 | 11:57:50 INFO - PROCESS | 2475 | [#0] ai-astar Cycles:10 Average:133.80 Median:150.00 stddev:31.00 (20.7%) stddev-sans-first:31.33 11:57:50 INFO - PROCESS | 2475 | Values: 107.0 98.0 177.0 177.0 178.0 121.0 123.0 115.0 120.0 122.0 11:57:50 INFO - PROCESS | 2475 | 11:57:50 INFO - PROCESS | 2475 | [#1] audio-beat-detection Cycles:10 Average:124.40 Median:130.00 stddev:15.95 (12.3%) stddev-sans-first:15.08 11:57:50 INFO - PROCESS | 2475 | Values: 145.0 112.0 108.0 144.0 124.0 108.0 113.0 111.0 136.0 143.0 11:57:50 INFO - PROCESS | 2475 | 11:57:50 INFO - PROCESS | 2475 | [#2] audio-dft Cycles:10 Average:213.70 Median:200.00 stddev:30.28 (15.1%) stddev-sans-first:31.58 11:57:50 INFO - PROCESS | 2475 | Values: 198.0 220.0 288.0 244.0 197.0 201.0 197.0 199.0 197.0 196.0 11:57:50 INFO - PROCESS | 2475 | 11:57:50 INFO - PROCESS | 2475 | [#3] audio-fft Cycles:10 Average:68.00 Median:65.50 stddev:10.78 (16.5%) stddev-sans-first:9.26 11:57:50 INFO - PROCESS | 2475 | Values: 86.0 58.0 60.0 87.0 62.0 63.0 68.0 60.0 74.0 62.0 11:57:50 INFO - PROCESS | 2475 | 11:57:50 INFO - PROCESS | 2475 | [#4] audio-oscillator Cycles:10 Average:77.30 Median:77.50 stddev:8.58 (11.1%) stddev-sans-first:8.50 11:57:50 INFO - PROCESS | 2475 | Values: 86.0 70.0 87.0 73.0 72.0 71.0 82.0 72.0 68.0 92.0 11:57:50 INFO - PROCESS | 2475 | 11:57:50 INFO - PROCESS | 2475 | [#5] imaging-gaussian-blur Cycles:10 Average:90.90 Median:89.00 stddev:6.79 (7.6%) stddev-sans-first:7.19 11:57:50 INFO - PROCESS | 2475 | Values: 90.0 90.0 88.0 88.0 90.0 110.0 87.0 89.0 88.0 89.0 11:57:50 INFO - PROCESS | 2475 | 11:57:50 INFO - PROCESS | 2475 | [#6] imaging-darkroom Cycles:10 Average:117.90 Median:96.00 stddev:24.47 (25.5%) stddev-sans-first:22.64 11:57:50 INFO - PROCESS | 2475 | Values: 152.0 152.0 98.0 96.0 118.0 96.0 97.0 128.0 145.0 97.0 11:57:50 INFO - PROCESS | 2475 | 11:57:50 INFO - PROCESS | 2475 | [#7] imaging-desaturate Cycles:10 Average:106.10 Median:90.00 stddev:23.73 (26.4%) stddev-sans-first:24.98 11:57:50 INFO - PROCESS | 2475 | Values: 98.0 94.0 90.0 82.0 148.0 147.0 103.0 90.0 92.0 117.0 11:57:50 INFO - PROCESS | 2475 | 11:57:50 INFO - PROCESS | 2475 | [#8] json-parse-financial Cycles:10 Average:66.90 Median:68.00 stddev:1.79 (2.6%) stddev-sans-first:1.90 11:57:50 INFO - PROCESS | 2475 | Values: 67.0 65.0 63.0 66.0 68.0 68.0 67.0 68.0 68.0 69.0 11:57:50 INFO - PROCESS | 2475 | 11:57:50 INFO - PROCESS | 2475 | [#9] json-stringify-tinderbox Cycles:10 Average:65.80 Median:67.00 stddev:9.76 (14.6%) stddev-sans-first:10.04 11:57:50 INFO - PROCESS | 2475 | Values: 59.0 65.0 69.0 74.0 57.0 59.0 58.0 58.0 72.0 87.0 11:57:50 INFO - PROCESS | 2475 | 11:57:50 INFO - PROCESS | 2475 | [#10] stanford-crypto-aes Cycles:10 Average:89.40 Median:80.50 stddev:10.61 (13.2%) stddev-sans-first:10.69 11:57:50 INFO - PROCESS | 2475 | Values: 80.0 101.0 73.0 92.0 100.0 101.0 100.0 82.0 84.0 81.0 11:57:50 INFO - PROCESS | 2475 | 11:57:50 INFO - PROCESS | 2475 | [#11] stanford-crypto-ccm Cycles:10 Average:156.40 Median:159.00 stddev:20.75 (13.0%) stddev-sans-first:20.65 11:57:50 INFO - PROCESS | 2475 | Values: 136.0 134.0 170.0 143.0 141.0 166.0 147.0 152.0 198.0 177.0 11:57:50 INFO - PROCESS | 2475 | 11:57:50 INFO - PROCESS | 2475 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.10 Median:167.00 stddev:4.82 (2.9%) stddev-sans-first:5.09 11:57:50 INFO - PROCESS | 2475 | Values: 166.0 169.0 165.0 161.0 171.0 168.0 164.0 166.0 163.0 178.0 11:57:50 INFO - PROCESS | 2475 | 11:57:50 INFO - PROCESS | 2475 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:66.50 stddev:5.29 (8.0%) stddev-sans-first:5.39 11:57:50 INFO - PROCESS | 2475 | Values: 63.0 67.0 63.0 64.0 67.0 66.0 63.0 66.0 74.0 79.0 11:57:50 INFO - PROCESS | 2475 | -------- Summary: end -------- 11:57:50 INFO - PROCESS | 2475 | 11:57:51 INFO - TEST-INFO | 2475: exit 0 11:57:51 INFO - TEST-OK | kraken | took 60809ms 11:57:51 INFO - SUITE-END | took 1175s 11:57:51 INFO - Completed test suite (00:19:36) 11:57:51 INFO - javascript benchmark 11:57:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7979.707651672391, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3511.84196711148, 3522.9823850880744, 3534.0634731796094, 3542.1144713821545, 3564.554430696163, 5889.970550147254, 5927.792527261541, 5942.524598032158, 5985.0, 6016.639001659903, 5989.640621562709, 6020.939790602092, 6030.517558595313, 6033.245844269466, 6085.4218849209365, 5331.866703332418, 5336.092864213074, 5354.250404943311, 5390.056740070472, 5470.699111548864, 5412.161115027177, 5413.0, 5421.403645598981, 5423.0, 5435.10320797068, 5214.8696282592855, 5233.842984710464, 5394.02907476654, 5431.755570999295, 5450.264214331074, 5359.196120581905, 5383.138697808351, 5437.972810135924, 5486.945130548684, 5507.311586051744, 5310.946890531122, 5372.650777699476, 5372.865678358073, 5389.083855744533, 5409.999150157233, 5199.558037566811, 5680.091185410314, 6058.606190597641, 6105.0, 6134.018557030854, 6236.688165591748, 6239.032949892774, 6286.339934306878, 6293.024581189923, 6344.936550634527, 6426.228852537679, 6434.356564343575, 6436.581622194542, 6445.967770161119, 6447.677616119176, 5338.199270109515, 6024.246969128859, 6070.059140833089, 6111.755529778803, 6183.845403864894, 6266.060090986297, 6305.621662700252, 6376.968115159488, 6477.708503117276, 6497.447716944018, 6296.622202667854, 6314.494840412756, 6336.334684858116, 6344.968275158594, 6351.777687780906, 6312.589681670676, 6333.873322533524, 6359.459445947054, 6373.458256048195, 6384.201974753156, 6199.473044791243, 6223.719932603044, 6277.1525844010475, 6366.395192456709, 6374.521910856704, 6278.0269058296035, 6298.338674439209, 6318.7472501100365, 6320.178376810985, 6332.873342533216, 5111.412187598399, 5111.821086261963, 5117.5394214520875, 5136.9743151284, 5148.407933087743, 4465.084657645175, 4576.427946506687, 4585.862424127282, 4594.402727645384, 4605.125026245069, 5881.823545293648, 5979.611325263844, 6051.636901785907, 6127.0, 6142.508599312045, 6340.239171299474, 6342.080398342215, 6411.807645770635, 6415.454686351619, 6417.262014868256, 5888.205092312569, 5954.702264886739, 6118.908216376758, 6158.507319414436, 6231.345708700612, 5543.750531226105, 5659.094544872801, 5675.5459563234845, 5685.403032681592, 5698.373178950312, 6548.1814773153355, 6600.207975043026, 6603.603783772989, 6609.438197753053, 6614.536982411185, 6239.220097487814, 6240.719167637377, 6318.6840657965995, 6416.518761092843, 6445.484361250995, 6445.677716114082, 6485.481161507162, 6498.447631951337, 6510.707018184098, 6519.054737063194, 6342.936570634234, 6351.015592583157, 6362.459190968634, 6363.90454143179, 6369.267534233622, 6253.468455181361, 6320.557560970872, 6360.918643830468, 6381.457576106083, 6397.8720425592155, 6219.0982307566055, 6241.126242325987, 6245.0632405139595, 6310.021946598285, 6331.430171284606, 6258.217722784652, 6274.1843560336865, 6308.14839996613, 6326.746930122928, 6327.050942358683, 5932.377100404396, 6220.253569571681, 6259.217597800275, 6266.404691554295, 6272.655003974825, 6161.507079433724, 6199.56603037783, 6205.937940620716, 6224.719887604978, 6295.1186833842385, 6211.596246243979, 6256.092866534418, 6264.436200741955, 6266.937330626635, 6277.811665650038], "value": 5894.0746913241865, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [759.5328872743264, 830.3398797955625, 854.95268296337, 931.7856892914633, 948.4972964328908, 38889.41665875011, 39985.60014399855, 41632.37551436723, 41655.958601035025, 41729.79135104328, 39528.22123004465, 39590.406143907865, 39714.60285397145, 39790.602093979054, 39811.80094099533, 8312.54281014544, 8431.325493960469, 11253.887461125365, 11525.308481491138, 11716.765664686744, 11349.546018159264, 11409.31544107352, 11465.656030319104, 11486.540538378496, 11495.0, 10145.086942175203, 11067.778644427106, 11456.599019034335, 11474.426278686075, 11478.655640330762, 11398.544058237661, 11438.142139339541, 11448.656540303804, 11468.31190128595, 11478.196526243166, 11101.666949991513, 11133.665990020312, 11153.944230278878, 11178.608748693838, 11182.384968826711, 35306.29387412263, 35324.64675353239, 35518.467222991676, 35519.467207991904, 35524.64475355265, 3900.4734360861203, 3911.6283953024417, 3942.448057271984, 4019.4975628046495, 4149.211649786531, 25798.355041123934, 26048.34879128018, 26113.955441782306, 26244.606330904862, 26401.0, 3222.532732753761, 3288.5724855768835, 3311.2218628622254, 3402.5406570112964, 3428.297199074184, 369821.0, 372385.0, 418229.0, 423950.0, 460882.6955865233, 52332.69168270824, 52593.7370313146, 56230.156547651815, 56261.437385626436, 56797.58006049799, 56885.43114568884, 57136.42863571394, 57411.13883291754, 57468.71265643645, 57636.0, 15833.524994249961, 15894.284757185724, 15908.840911590967, 15951.840481595036, 16218.594535136715, 13787.793183102262, 13798.241096739575, 13845.861541384456, 13855.584332470042, 13907.026508144332, 13756.243406612732, 13786.724265514633, 13790.793138102936, 13835.584932452042, 13839.54684758086, 6010.879782404415, 6045.6070355426755, 6052.818415447544, 6059.848503787441, 6061.939380606225, 1167.3579531257774, 1178.3165763856941, 1183.8579370475427, 1200.5557943560764, 1213.4467881112191, 24481.775911204368, 28819.855900720362, 29055.983040593477, 29159.416811663647, 29390.265243369086, 1290.619267316144, 1291.3994992328612, 1304.8695130487065, 1342.1142046249429, 1349.6221058103747, 14474.782878256834, 14539.41842326295, 14893.32980015902, 14913.776293355608, 15159.0, 499330.0, 501025.0, 501882.0, 503027.0, 503785.0, 59145.704271479226, 59618.0, 59635.80728385408, 59787.40212597905, 59810.401895981355, 1474.6165996840684, 1492.6193820575684, 1539.122700060977, 1548.7754275630195, 1551.5965848879373, 27074.458510829278, 28394.432111357244, 28464.57303140496, 32542.0, 33207.16982075467, 58480.4151958492, 62174.0, 62296.06555901575, 62304.0, 62463.37536624575, 501864.0, 504468.0, 507081.0, 507692.0, 510187.0, 31198.0, 38297.0, 39430.802845985585, 40733.38899916445, 40779.7961010193, 47222.52777472319, 47429.0, 47823.5217647833, 48622.27066593933, 49255.753721231165, 32454.67545324611, 32620.83689581537, 33026.33947321088, 33369.0, 33808.830955845064, 27690.44619107647, 32685.836570816995, 32863.50704739383, 33522.82670106534, 33684.66315336815, 31966.68033319637, 32733.508997365534, 40153.79923100366, 40366.59633403629, 40622.0, 25713.614295785952, 32324.515132272565, 32606.51090233601, 33421.33157336888, 33522.832385837915, 22373.9931703077, 25788.0, 26223.4755304889, 26482.602760958987, 26970.0], "value": 20261.131814327982, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [410.15712710380166, 418.8136279355688, 438.2090326959837, 440.10715652506707, 444.6842741653424, 20248.291309804143, 21323.040463179157, 22472.32583022508, 22646.773532264673, 22689.86550672466, 22392.440188995282, 22534.0, 22593.0, 22803.657945130835, 24224.636630450514, 6901.44788416928, 6911.48163887708, 7122.66592347812, 7191.604461754601, 7213.963930180368, 6830.760923367683, 6988.301169883021, 7046.506744527859, 7050.471214658921, 7050.625128100022, 6826.317368263183, 6973.198082220559, 6983.266756990519, 7035.226125126232, 7090.0, 6702.765403210913, 7047.119110111236, 7052.576845389293, 7083.574985500886, 7126.536775109627, 6825.1127353444235, 6828.829279268058, 6838.589684618939, 6840.179178498612, 6842.384185423336, 27391.45217095667, 27949.86025069882, 28099.0165344214, 28163.29591760202, 28238.0, 3556.5732112146447, 3607.512985746917, 3622.130688634735, 3631.092226943264, 3650.762700424464, 16723.749143762852, 17258.395956141474, 17923.551911202194, 17948.14583426304, 18355.908220458947, 1946.99026504868, 2168.6530155175096, 2169.262450766747, 2201.438633148553, 2205.933821985343, 111377.0, 129144.41711165819, 133501.3324933379, 137167.31416342955, 138217.6178238215, 20166.596668066555, 22074.22740204085, 23600.409989750395, 23778.64332035021, 24262.393440164138, 31290.37419251602, 37245.25509489849, 37429.81285093611, 38141.80929095392, 38175.472981081, 11411.429428528707, 11554.94222528882, 11608.419579021016, 11691.590794322328, 11940.0, 9463.290253231035, 9466.053394660617, 9494.905050949541, 9645.08371704687, 9732.07545283197, 8868.689595864114, 9318.767030824149, 9879.654212102541, 11178.161637877192, 11280.943595282135, 3701.5188025556504, 3925.495892557012, 4329.913401732011, 4427.933580996288, 4482.686211965196, 898.2723993565234, 942.1850099663742, 1050.417018554694, 1054.9555939619875, 1059.4067322299536, 23286.65070023951, 23335.41661458477, 23347.7665223349, 23422.882885585805, 23552.76447235506, 1041.9374837509774, 1043.6451606453843, 1047.8061558611528, 1082.5345101606226, 1084.9891501084887, 11859.88140118605, 12119.0, 12267.202631828903, 12276.693082672826, 12334.81497777534, 511931.0, 640812.0, 649394.0, 689186.0, 820173.0, 116164.0, 124325.0, 156938.0, 174469.0, 177575.0, 1323.9536616218386, 1365.5797970110973, 1386.6186798630256, 1390.3534856291874, 1394.28194479845, 19119.13963871657, 20398.0, 20562.485937851674, 20586.588268234253, 20602.69095963592, 66058.66970665116, 67148.6642566784, 67492.66253668896, 68060.6596967012, 69521.30478695148, 96229.5188524053, 96939.54590681287, 97841.0, 100764.49617751864, 101561.98438015525, 11812.81871812812, 11911.821322679993, 12089.0, 12109.939450302692, 12383.009359251058, 12189.878101218874, 13709.245991470167, 13738.65653358674, 13895.0, 13980.720385592434, 11683.357415342238, 11707.590234342098, 11867.643970680894, 11998.100142489522, 12142.028637708785, 10939.617113400993, 10986.560537578407, 11027.503762330554, 11141.986240889255, 11341.716457088638, 11768.52925882955, 11834.289942603471, 11932.0, 11937.98527125204, 12133.575324863587, 10202.948985255027, 11790.646280611596, 11817.995470385114, 12033.916947474769, 12150.392480376122, 10588.947055264982, 11585.710357241136, 11725.237859539102, 11931.463084161407, 12065.034797216025], "value": 12209.325869166782, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1579.6682696633707, 1619.295606411211, 1632.469447429585, 1643.6876993371259, 1652.8264532224116, 11084.0, 11664.82502762457, 11763.941180294098, 11767.293962362264, 11923.880761192386, 11398.316101033945, 11626.709332266697, 11635.185537012412, 11643.534258629667, 11656.475458604362, 2190.3538456155393, 2448.1064411489765, 2470.962935555968, 2522.432452698147, 2523.4322277487604, 2445.1441995301593, 2493.0401795308844, 2518.798496120315, 2531.5696331623576, 2539.7206307306183, 2474.9752502475017, 2490.103562717429, 2501.499700059986, 2508.7742103210708, 2510.184190138203, 2453.141400509825, 2457.987710061447, 2468.049800826686, 2473.319837044809, 2499.7750202481684, 2499.387650025755, 2514.861682607456, 2519.206449968254, 2519.9748002519923, 2527.0902475108946, 9894.0, 11389.886101139049, 11541.249818761753, 11588.942055289754, 11626.76746465066, 6025.367336429656, 6157.0456579230295, 6206.100115483275, 6206.782762603287, 6222.066689996492, 3400.472926696366, 3642.016655503026, 3692.9630703692887, 3696.2792255510185, 3775.2826962876966, 1143.3597185576104, 1230.889219970207, 1242.614789415275, 1264.4183675509184, 1304.3673818198167, 14326.35531401079, 14683.926580367137, 15196.240187990667, 15825.129617871013, 16009.599760005976, 4522.050369422393, 4784.354112194878, 4796.5203479651755, 4833.419989601271, 5020.548150666457, 10167.28828981979, 12195.817062744067, 12228.0, 12259.754804903852, 12266.938665306616, 6065.120557519135, 6124.816255512342, 6133.6013159145405, 6134.0, 6162.599431036968, 5555.2500412444615, 5561.610687251854, 5573.916391254134, 5653.321601407857, 5734.483896449339, 3471.2363280078343, 3862.5944275851193, 3988.66096381805, 4026.959730402717, 4052.5542190359038, 1082.86464191976, 1093.278436232083, 1099.115212254127, 1103.45379037377, 1108.5842808946645, 985.9260555458226, 1003.5082809423476, 1006.5124344147564, 1012.488693209939, 1021.8518314844455, 6894.345037221456, 6960.269171736996, 7015.333543313377, 7120.252373500812, 7135.179454362711, 1024.6618615856898, 1025.3437799808128, 1027.198784947742, 1040.557762950743, 1041.6458404142627, 4220.303649897794, 4317.6114149726045, 4363.716358436692, 4402.603765661106, 4432.246518091933, 13728.313584320744, 14181.361838717075, 14207.85792142086, 14306.713865722835, 14323.57029289123, 13879.306034698224, 14271.286435678174, 14285.57143285703, 14289.142651440947, 14293.428262869369, 8998.650202469551, 10410.531526081344, 10643.627473038407, 10668.946655266674, 10723.624673136403, 6665.133532640726, 6793.796186114425, 6988.266232045562, 7290.781276561712, 7317.670704818403, 11852.822207667065, 11962.898366893982, 11963.342016188844, 12050.975667068398, 12086.758264834478, 12476.875231247934, 12478.875211248134, 12577.371131443208, 12592.874071259537, 12756.043296752596, 8442.746717598482, 8638.740837774876, 8640.265577425738, 8683.609237584451, 8691.913080869363, 8867.379283450096, 10397.0, 10470.162387008868, 10691.786164276515, 10853.511591978222, 9084.818303634023, 9187.08129187076, 9266.629334826532, 9436.858447123435, 9458.810823783624, 8998.55007249648, 8999.0, 9013.909860901307, 9130.771730706785, 9263.629454822001, 7146.0, 8394.916050839414, 8475.957620211859, 8487.448315859448, 8492.065872753868, 6099.2985806632805, 6112.786052488142, 6117.418845209698, 6273.059041143865, 6305.274893387135, 6130.47890929276, 6275.37246275387, 6283.37166283368, 6325.841853953688, 6408.327125651739], "value": 5318.476642802434, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.9332013557695, 396.0494812450119, 396.21549332322, 398.2457275700538, 403.1694708899667, 5012.29827824104, 5046.0412521620865, 5239.711815850127, 5294.126469132593, 5314.654547454413, 4029.758214507124, 4552.590266875981, 4722.268048452487, 4847.248676455146, 5046.671966322187, 3266.738660907122, 4033.781420218875, 4046.534648515429, 4057.6753859691303, 4060.3909413587903, 3473.7742046767007, 3639.4896118111083, 3829.40644200148, 4071.5774114401884, 4072.8370865165357, 4057.1539949323133, 4058.5738497457783, 4071.653909417703, 4075.347944328893, 4076.6331030207275, 3054.6996327063894, 3392.983035084821, 3816.122291872857, 4056.5721964939876, 4121.433855135059, 3607.2424790793966, 3625.0393645683916, 3626.9818650906577, 3645.981770091159, 3650.032741323525, 4422.363725421583, 4470.725843134724, 4508.797104130322, 4637.165310244155, 4701.506341834092, 4184.539700632928, 4568.497465278817, 4672.719636821767, 4781.091592597395, 4828.106800241966, 5475.521609165543, 5480.972595137038, 5489.862753431156, 5505.614606977513, 5528.308961379827, 3666.0651533858963, 3954.8220330085214, 4016.819243134066, 4035.273650742865, 4037.051292946155, 5503.862403439946, 5698.6865722385255, 5782.56630752691, 5787.50806181475, 5799.652020878719, 3635.437016903077, 3894.279558281727, 4079.7348172369293, 4085.4280400743323, 4101.015756218546, 3679.889603311905, 3998.7600743955454, 4167.666106980101, 4199.97900010498, 4204.747715137101, 4213.578642135762, 4373.775342903992, 4642.744649044335, 4710.458297295786, 4770.713757174581, 5465.863353416117, 5487.734797795305, 5514.944850551524, 5574.386817450078, 5643.774249030075, 1555.7121932442535, 1604.8876578639617, 1617.6360318928148, 1704.4545745361613, 1720.346268418018, 1096.1231015187818, 1168.6201984354948, 1247.906407019459, 1311.3902035553513, 1379.9586012419643, 4555.908881822411, 5297.708626025606, 5313.0, 5330.493603107699, 5365.973170134124, 4804.237563401059, 5121.743912804345, 5230.8169214077325, 5234.581233501311, 5807.593468457252, 4755.500672429345, 4941.382327209099, 5071.207708715302, 5244.967886438115, 5337.332833395825, 2499.5875680512877, 2594.9481010379686, 2978.5554006306925, 2991.685872983349, 2999.5650630658433, 5062.367204099488, 5863.325717542537, 5885.793997210163, 5915.112733090071, 5949.434803693643, 5383.300170977748, 5597.160425936061, 5605.887882242332, 5775.306963164448, 6023.789167379121, 5284.392294886137, 5750.7987220447085, 5784.587093614788, 5944.286685597756, 5950.166976623276, 5162.328897243335, 5346.866328341823, 5542.644376140205, 5710.0, 5746.569007324551, 5212.687238765686, 5315.335583052119, 5565.610407271614, 5574.888502229852, 5643.576731745054, 5105.463926287686, 5348.545373643284, 5923.881522369615, 6092.9086063709965, 6093.238345206849, 4143.56492568276, 4470.329450582309, 4567.3785806039705, 4606.216943119611, 4612.53874612536, 4936.432310284364, 5503.752331145028, 5712.514436272963, 5803.65178089316, 5804.9709751452665, 4376.452943382077, 5126.384833819965, 5490.325450737404, 5499.9000199960965, 5541.889162216814, 4450.955490445054, 4562.908741825211, 5251.844594189272, 5610.85972850682, 5677.3754886963225, 5221.616271688082, 5387.272718182995, 5414.0, 5438.374586922555, 5498.532624726943, 4769.76151192432, 4948.406191257072, 4973.593088734228, 5557.722113894209, 5562.860928476659, 4691.7184968901975, 5338.866528336823, 5470.589705772162, 5506.779728810803, 5549.361823390362], "value": 4163.920637756948, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [750.6059318857602, 770.1066762555437, 798.7164556582413, 881.8060026794107, 888.0364804187458, 15834.841651583482, 17465.563360915985, 17983.920964742123, 18002.009889456076, 18057.0, 16260.186990650449, 16324.428644997428, 16595.66808663826, 16687.749683754755, 16715.164241787894, 999.605155963394, 1018.7707765752721, 1023.2734758321601, 1024.748936510556, 1026.8921763214867, 984.9753756156117, 1018.9847152292684, 1023.5649848814261, 1024.933379330341, 1027.4451796030173, 1064.8562444070028, 1066.983995240072, 1068.6633710381243, 1069.4225118436036, 1069.7860427914409, 1053.3837704942619, 1056.7622284985816, 1063.0857462582173, 1064.2922456566373, 1065.4566171252677, 775.53467919248, 782.0732432067961, 788.0425283280784, 789.4000559574707, 793.4326956226269, 16898.324067037305, 17046.40337588191, 17296.91351543234, 17632.471025869243, 17707.38024169148, 12119.939400302943, 13896.861031389759, 13908.652283692887, 14193.929030354782, 14220.288985550682, 12006.219595726338, 12177.756444871053, 12189.390530473442, 12234.265944043385, 12237.816432753516, 3806.0675134591925, 3867.7485963412287, 3906.0625449892104, 3942.9605703943166, 4053.047533829548, 95289.0, 95544.04455955491, 107550.0, 114672.42663786712, 118702.40648796788, 11444.313341199555, 11510.712232194095, 11581.744450063048, 11784.116191285688, 11819.527218911318, 23572.821358931986, 23934.64098038531, 24062.39844003914, 24267.63598546023, 24441.87779061093, 7623.546294358567, 7858.724944627025, 8170.509769413854, 8322.375821813388, 8363.916360836314, 4593.104344652761, 4627.791749371219, 4725.598324142417, 4792.329073929653, 4816.831410900601, 3444.603870554868, 3541.309444658267, 3544.610092889832, 3544.9822750886083, 3561.554805649294, 607.9787207447719, 610.9450149486568, 616.950643948483, 631.43171145969, 633.2084893882646, 689.2074114768056, 692.1728534401443, 711.7081996381562, 728.8884451211944, 739.9593022383713, 10792.0, 10841.512131954081, 11071.280366776135, 11281.0, 11347.0, 692.3906961873519, 718.741253148866, 725.1117381208084, 732.3957734868754, 736.819479227582, 5049.394072711299, 5067.391912970467, 5265.289185959923, 5329.280547126166, 5377.166539186433, 100641.99358006327, 109617.0, 110481.44759276153, 111501.0, 111693.44153279181, 59413.0, 74025.88961165588, 79349.60325198337, 85819.57090214509, 97726.51136744271, 58752.0, 66673.0, 70035.64982175159, 75020.24979750242, 76078.0, 8737.91262087371, 10863.945680271549, 11019.228653994143, 11137.777244454903, 11583.131265154978, 48607.0, 51263.487365125875, 52839.73580132075, 52972.47027529676, 53764.73117634387, 69384.95922561064, 71448.64275678588, 71504.0, 72334.63832680802, 73395.0, 13519.391627376595, 13621.659458513617, 13659.9755018376, 13699.972502062585, 13816.101953372998, 15498.302576384316, 15602.492112939037, 15759.763603546186, 15949.760753588938, 16090.919545402197, 14433.278336083364, 14487.92756036213, 14584.979051466296, 14781.852181478478, 15313.234338283264, 14260.215688137252, 14629.195394253418, 14689.045212061183, 14694.63263418423, 15233.466828660943, 11818.940905295418, 13872.929792644676, 14484.493042743454, 14547.927260363631, 14631.85368146305, 8948.032580015915, 9999.20006399501, 10365.0, 10379.273450858367, 10573.418461984666, 10547.736306592396, 10840.0, 10918.727031824268, 12096.879031209928, 12336.691582710504], "value": 7994.968469551826, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1544.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 98.0, 177.0, 177.0, 178.0, 121.0, 123.0, 115.0, 120.0, 122.0], "value": 133.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 112.0, 108.0, 144.0, 124.0, 108.0, 113.0, 111.0, 136.0, 143.0], "value": 124.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 220.0, 288.0, 244.0, 197.0, 201.0, 197.0, 199.0, 197.0, 196.0], "value": 213.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 58.0, 60.0, 87.0, 62.0, 63.0, 68.0, 60.0, 74.0, 62.0], "value": 68.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 70.0, 87.0, 73.0, 72.0, 71.0, 82.0, 72.0, 68.0, 92.0], "value": 77.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 90.0, 88.0, 88.0, 90.0, 110.0, 87.0, 89.0, 88.0, 89.0], "value": 90.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 152.0, 98.0, 96.0, 118.0, 96.0, 97.0, 128.0, 145.0, 97.0], "value": 117.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 94.0, 90.0, 82.0, 148.0, 147.0, 103.0, 90.0, 92.0, 117.0], "value": 106.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 63.0, 66.0, 68.0, 68.0, 67.0, 68.0, 68.0, 69.0], "value": 66.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 65.0, 69.0, 74.0, 57.0, 59.0, 58.0, 58.0, 72.0, 87.0], "value": 65.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 101.0, 73.0, 92.0, 100.0, 101.0, 100.0, 82.0, 84.0, 81.0], "value": 89.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 134.0, 170.0, 143.0, 141.0, 166.0, 147.0, 152.0, 198.0, 177.0], "value": 156.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 169.0, 165.0, 161.0, 171.0, 168.0, 164.0, 166.0, 163.0, 178.0], "value": 167.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 67.0, 63.0, 64.0, 67.0, 66.0, 63.0, 66.0, 74.0, 79.0], "value": 67.2, "unit": "score"}]}]} 11:57:51 INFO - Return code: 0 11:57:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:57:51 ERROR - # TBPL SUCCESS # 11:57:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:57:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:57:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:57:51 INFO - 2017-04-30 11:57:51.886 screenresolution[2480:38866] starting screenresolution argv=screenresolution get 11:57:51 INFO - 2017-04-30 11:57:51.889 screenresolution[2480:38866] Display 0: 1600x1200x32@60 11:57:51 INFO - 2017-04-30 11:57:51.895 screenresolution[2481:38869] starting screenresolution argv=screenresolution list 11:57:51 INFO - Available Modes on Display 0 11:57:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:57:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:57:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:57:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:57:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:57:52 INFO - Intel Iris: 11:57:52 INFO - Chipset Model: Intel Iris 11:57:52 INFO - Type: GPU 11:57:52 INFO - Bus: Built-In 11:57:52 INFO - VRAM (Dynamic, Max): 1536 MB 11:57:52 INFO - Vendor: Intel (0x8086) 11:57:52 INFO - Device ID: 0x0a2e 11:57:52 INFO - Revision ID: 0x0009 11:57:52 INFO - Displays: 11:57:52 INFO - Display: 11:57:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:57:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:57:52 INFO - Display Serial Number: 1600x1200 60 11:57:52 INFO - Main Display: Yes 11:57:52 INFO - Mirror: Off 11:57:52 INFO - Online: Yes 11:57:52 INFO - Rotation: Supported 11:57:52 INFO - Return code: 0 11:57:52 INFO - Running post-action listener: _resource_record_post_action 11:57:52 INFO - [mozharness: 2017-04-30 18:57:52.137026Z] Finished run-tests step (success) 11:57:52 INFO - Running post-run listener: _resource_record_post_run 11:57:52 INFO - Total resource usage - Wall time: 1191s; CPU: 55.0%; Read bytes: 2113536; Write bytes: 430597120; Read time: 17; Write time: 1995 11:57:52 INFO - TinderboxPrint: CPU usage
54.5% 11:57:52 INFO - TinderboxPrint: I/O read bytes / time
2,113,536 / 17 11:57:52 INFO - TinderboxPrint: I/O write bytes / time
430,597,120 / 1,995 11:57:52 INFO - TinderboxPrint: CPU idle
2,166.2 (45.5%) 11:57:52 INFO - TinderboxPrint: CPU system
961.8 (20.2%) 11:57:52 INFO - TinderboxPrint: CPU user
1,637.7 (34.4%) 11:57:52 INFO - TinderboxPrint: Swap in / out
123,822,080 / 0 11:57:52 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 122739200; Write bytes: 122683392; Read time: 11123; Write time: 255 11:57:52 INFO - run-tests - Wall time: 1177s; CPU: 55.0%; Read bytes: 1089536; Write bytes: 306361344; Read time: 10; Write time: 1701 11:57:52 INFO - Running post-run listener: _upload_blobber_files 11:57:52 INFO - Blob upload gear active. 11:57:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:57:52 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:57:52 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:57:52 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:57:53 INFO - (blobuploader) - INFO - Open directory for files ... 11:57:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:57:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:57:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:57:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:57:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:57:53 INFO - (blobuploader) - INFO - Done attempting. 11:57:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:57:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:57:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:57:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:57:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:57:54 INFO - (blobuploader) - INFO - Done attempting. 11:57:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:57:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:57:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:57:55 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:57:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:57:55 INFO - (blobuploader) - INFO - Done attempting. 11:57:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:57:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:57:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:57:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:57:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:57:57 INFO - (blobuploader) - INFO - Done attempting. 11:57:57 INFO - (blobuploader) - INFO - Iteration through files over. 11:57:57 INFO - Return code: 0 11:57:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:57:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:57:57 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e163bee922d6898f9d6c85ff804f6fc8403da9e27f00758f2e68968f63b85af585faed432ff5ca92f5911f048152202089f1b954b22592174f5a57afc0041132", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f7eb36f407cd93f52486b485ecc6f808f23d98c9f936c7c6b52513f21268449c45cb296d11aaafae665397eaf842f9d526bce3273c975755743fdff5330a8b28", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d1d6713a1d2b93d6d0b52033df87974b2dee9cb8d0a1dce46805d245e659dab23dcde64f8a3847a7d1102e5fe5469c5ba4fc5202d0bf83b33b8923c43f64b421", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/db308cc752110beb768fc0cacce4ccf9f8f5604baed6438a75067185b476155c562d66695e49af9bfb7cd80fecf7aa2f04a8212272cd43a54b8adcd62d899d55"} 11:57:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:57:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:57:57 INFO - Contents: 11:57:57 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e163bee922d6898f9d6c85ff804f6fc8403da9e27f00758f2e68968f63b85af585faed432ff5ca92f5911f048152202089f1b954b22592174f5a57afc0041132", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f7eb36f407cd93f52486b485ecc6f808f23d98c9f936c7c6b52513f21268449c45cb296d11aaafae665397eaf842f9d526bce3273c975755743fdff5330a8b28", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d1d6713a1d2b93d6d0b52033df87974b2dee9cb8d0a1dce46805d245e659dab23dcde64f8a3847a7d1102e5fe5469c5ba4fc5202d0bf83b33b8923c43f64b421", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/db308cc752110beb768fc0cacce4ccf9f8f5604baed6438a75067185b476155c562d66695e49af9bfb7cd80fecf7aa2f04a8212272cd43a54b8adcd62d899d55"} 11:57:57 INFO - Running post-run listener: copy_logs_to_upload_dir 11:57:57 INFO - Copying logs to upload dir... 11:57:57 INFO - mkdir: /builds/slave/test/build/upload/logs 11:57:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.864139 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2017-04-30 11:57:57.567197) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-30 11:57:57.570472) ========= 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.xgGapgwaer/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.Eg1xMP1f58/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e163bee922d6898f9d6c85ff804f6fc8403da9e27f00758f2e68968f63b85af585faed432ff5ca92f5911f048152202089f1b954b22592174f5a57afc0041132", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f7eb36f407cd93f52486b485ecc6f808f23d98c9f936c7c6b52513f21268449c45cb296d11aaafae665397eaf842f9d526bce3273c975755743fdff5330a8b28", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d1d6713a1d2b93d6d0b52033df87974b2dee9cb8d0a1dce46805d245e659dab23dcde64f8a3847a7d1102e5fe5469c5ba4fc5202d0bf83b33b8923c43f64b421", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/db308cc752110beb768fc0cacce4ccf9f8f5604baed6438a75067185b476155c562d66695e49af9bfb7cd80fecf7aa2f04a8212272cd43a54b8adcd62d899d55"} build_url:https://queue.taskcluster.net/v1/task/VEZ5b-lFQx6VWvRdkrgAhw/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010848 build_url: 'https://queue.taskcluster.net/v1/task/VEZ5b-lFQx6VWvRdkrgAhw/artifacts/public/build/firefox-54.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e163bee922d6898f9d6c85ff804f6fc8403da9e27f00758f2e68968f63b85af585faed432ff5ca92f5911f048152202089f1b954b22592174f5a57afc0041132", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f7eb36f407cd93f52486b485ecc6f808f23d98c9f936c7c6b52513f21268449c45cb296d11aaafae665397eaf842f9d526bce3273c975755743fdff5330a8b28", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d1d6713a1d2b93d6d0b52033df87974b2dee9cb8d0a1dce46805d245e659dab23dcde64f8a3847a7d1102e5fe5469c5ba4fc5202d0bf83b33b8923c43f64b421", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/db308cc752110beb768fc0cacce4ccf9f8f5604baed6438a75067185b476155c562d66695e49af9bfb7cd80fecf7aa2f04a8212272cd43a54b8adcd62d899d55"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-30 11:57:57.605616) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-30 11:57:57.605991) ========= 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.xgGapgwaer/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.Eg1xMP1f58/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.005483 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-30 11:57:57.654735) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-30 11:57:57.655091) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-30 11:57:57.655432) ========= ========= Total master_lag: 0.25 =========