builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0165 starttime: 1471406806.94 results: success (0) buildid: 20160816184915 builduid: 27de75b4ff5349a29a49d67f62745462 revision: fe895421dfbe1f1f8f1fc6a39bb20774423a6d74 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-16 21:06:46.939246) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-16 21:06:46.939655) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-16 21:06:46.939943) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-16 21:06:46.966224) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 21:06:46.966492) ========= 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.v0eaMXJZvE/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.oL6OHIgTA7/Listeners TMPDIR=/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 --2016-08-16 21:06:46-- 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: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 13.0M=0.001s 2016-08-16 21:06:47 (13.0 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.492543 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 21:06:47.482659) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 21:06:47.482993) ========= 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.v0eaMXJZvE/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.oL6OHIgTA7/Listeners TMPDIR=/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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.028447 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 21:06:47.545711) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-08-16 21:06:47.546059) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev fe895421dfbe1f1f8f1fc6a39bb20774423a6d74 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev fe895421dfbe1f1f8f1fc6a39bb20774423a6d74 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.v0eaMXJZvE/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.oL6OHIgTA7/Listeners TMPDIR=/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 2016-08-16 21:06:47,623 truncating revision to first 12 chars 2016-08-16 21:06:47,623 Setting DEBUG logging. 2016-08-16 21:06:47,623 attempt 1/10 2016-08-16 21:06:47,623 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/fe895421dfbe?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-16 21:06:49,352 unpacking tar archive at: mozilla-central-fe895421dfbe/testing/mozharness/ program finished with exit code 0 elapsedTime=2.013438 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-08-16 21:06:49.582077) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-16 21:06:49.582417) ========= script_repo_revision: fe895421dfbe1f1f8f1fc6a39bb20774423a6d74 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-16 21:06:49.582791) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-16 21:06:49.583110) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-16 21:06:49.601573) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-08-16 21:06:49.601919) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.v0eaMXJZvE/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.oL6OHIgTA7/Listeners TMPDIR=/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 21:06:49 INFO - MultiFileLogger online at 20160816 21:06:49 in /builds/slave/test 21:06:49 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 21:06:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:06:49 INFO - {'append_to_log': False, 21:06:49 INFO - 'base_work_dir': '/builds/slave/test', 21:06:49 INFO - 'blob_upload_branch': 'Firefox', 21:06:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:06:49 INFO - 'branch': 'Firefox', 21:06:49 INFO - 'buildbot_json_path': 'buildprops.json', 21:06:49 INFO - 'config_files': ('talos/mac_config.py',), 21:06:49 INFO - 'default_actions': ('clobber', 21:06:49 INFO - 'read-buildbot-config', 21:06:49 INFO - 'download-and-extract', 21:06:49 INFO - 'populate-webroot', 21:06:49 INFO - 'create-virtualenv', 21:06:49 INFO - 'install', 21:06:49 INFO - 'run-tests'), 21:06:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:06:49 INFO - 'download_minidump_stackwalk': True, 21:06:49 INFO - 'download_symbols': 'ondemand', 21:06:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:06:49 INFO - 'tooltool.py': '/tools/tooltool.py', 21:06:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:06:49 INFO - '/tools/misc-python/virtualenv.py')}, 21:06:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:06:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:06:49 INFO - 'installer_path': 'installer.exe', 21:06:49 INFO - 'log_level': 'info', 21:06:49 INFO - 'log_name': 'talos', 21:06:49 INFO - 'log_to_console': True, 21:06:49 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:06:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:06:49 INFO - 'opt_config_files': (), 21:06:49 INFO - 'pip_index': False, 21:06:49 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:06:49 INFO - 'cmd': ('bash', 21:06:49 INFO - '-c', 21:06:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:06:49 INFO - 'enabled': True, 21:06:49 INFO - 'halt_on_failure': False, 21:06:49 INFO - 'name': 'check_screen_resolution'},), 21:06:49 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:06:49 INFO - 'cmd': ('bash', 21:06:49 INFO - '-c', 21:06:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:06:49 INFO - 'enabled': True, 21:06:49 INFO - 'halt_on_failure': False, 21:06:49 INFO - 'name': 'check_screen_resolution'},), 21:06:49 INFO - 'run_cmd_checks_enabled': True, 21:06:49 INFO - 'sps_profile': False, 21:06:49 INFO - 'sps_profile_interval': 0, 21:06:49 INFO - 'suite': 'dromaeojs', 21:06:49 INFO - 'system_bits': '32', 21:06:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:06:49 INFO - 'title': 't-yosemite-r7-0165', 21:06:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:06:49 INFO - 'use_talos_json': True, 21:06:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:06:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:06:49 INFO - 'work_dir': 'build'} 21:06:49 INFO - [mozharness: 2016-08-17 04:06:49.804691Z] Running clobber step. 21:06:49 INFO - Running pre-action listener: _resource_record_pre_action 21:06:49 INFO - Running main action method: clobber 21:06:49 INFO - rmtree: /builds/slave/test/build 21:06:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:06:51 INFO - Running post-action listener: _resource_record_post_action 21:06:51 INFO - [mozharness: 2016-08-17 04:06:51.964956Z] Finished clobber step (success) 21:06:51 INFO - [mozharness: 2016-08-17 04:06:51.965110Z] Running read-buildbot-config step. 21:06:51 INFO - Running pre-action listener: _resource_record_pre_action 21:06:51 INFO - Running main action method: read_buildbot_config 21:06:51 INFO - Using buildbot properties: 21:06:51 INFO - { 21:06:51 INFO - "project": "", 21:06:51 INFO - "product": "firefox", 21:06:51 INFO - "script_repo_revision": "production", 21:06:51 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 21:06:51 INFO - "repository": "", 21:06:51 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 21:06:51 INFO - "buildid": "20160816184915", 21:06:51 INFO - "pgo_build": "False", 21:06:51 INFO - "basedir": "/builds/slave/test", 21:06:51 INFO - "buildnumber": 61, 21:06:51 INFO - "slavename": "t-yosemite-r7-0165", 21:06:51 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 21:06:51 INFO - "platform": "yosemite_r7", 21:06:51 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 21:06:51 INFO - "branch": "mozilla-central", 21:06:51 INFO - "repo_path": "mozilla-central", 21:06:51 INFO - "revision": "fe895421dfbe1f1f8f1fc6a39bb20774423a6d74", 21:06:51 INFO - "stage_platform": "macosx64", 21:06:51 INFO - "builduid": "27de75b4ff5349a29a49d67f62745462", 21:06:51 INFO - "slavebuilddir": "test" 21:06:51 INFO - } 21:06:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/J6QO1xH7RZ2hzApZg4ETiw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 21:06:51 INFO - Running post-action listener: _resource_record_post_action 21:06:51 INFO - [mozharness: 2016-08-17 04:06:51.968788Z] Finished read-buildbot-config step (success) 21:06:51 INFO - [mozharness: 2016-08-17 04:06:51.968933Z] Running download-and-extract step. 21:06:51 INFO - Running pre-action listener: _resource_record_pre_action 21:06:51 INFO - Running main action method: download_and_extract 21:06:51 INFO - mkdir: /builds/slave/test/build/tests 21:06:51 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')]} 21:06:51 INFO - trying https://queue.taskcluster.net/v1/task/J6QO1xH7RZ2hzApZg4ETiw/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 21:06:51 INFO - Downloading https://queue.taskcluster.net/v1/task/J6QO1xH7RZ2hzApZg4ETiw/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 21:06:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J6QO1xH7RZ2hzApZg4ETiw/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 21:06:53 INFO - Downloaded 1199 bytes. 21:06:53 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 21:06:53 INFO - Using the following test package requirements: 21:06:53 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 21:06:53 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 21:06:53 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 21:06:53 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 21:06:53 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 21:06:53 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 21:06:53 INFO - u'jsshell-mac.zip'], 21:06:53 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 21:06:53 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 21:06:53 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 21:06:53 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 21:06:53 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 21:06:53 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 21:06:53 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 21:06:53 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 21:06:53 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 21:06:53 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 21:06:53 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 21:06:53 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 21:06:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:06:53 INFO - trying https://queue.taskcluster.net/v1/task/J6QO1xH7RZ2hzApZg4ETiw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 21:06:53 INFO - Downloading https://queue.taskcluster.net/v1/task/J6QO1xH7RZ2hzApZg4ETiw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 21:06:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J6QO1xH7RZ2hzApZg4ETiw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 21:06:54 INFO - Downloaded 16336697 bytes. 21:06:54 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 21:07:01 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 21:07:01 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')]} 21:07:01 INFO - trying https://queue.taskcluster.net/v1/task/J6QO1xH7RZ2hzApZg4ETiw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 21:07:01 INFO - Downloading https://queue.taskcluster.net/v1/task/J6QO1xH7RZ2hzApZg4ETiw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 21:07:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J6QO1xH7RZ2hzApZg4ETiw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 21:07:02 INFO - Downloaded 16336697 bytes. 21:07:02 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 21:07:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:07:08 INFO - trying https://queue.taskcluster.net/v1/task/J6QO1xH7RZ2hzApZg4ETiw/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 21:07:08 INFO - Downloading https://queue.taskcluster.net/v1/task/J6QO1xH7RZ2hzApZg4ETiw/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip 21:07:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J6QO1xH7RZ2hzApZg4ETiw/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 21:07:09 INFO - Downloaded 14413719 bytes. 21:07:09 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 21:07:10 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')]} 21:07:10 INFO - trying https://queue.taskcluster.net/v1/task/J6QO1xH7RZ2hzApZg4ETiw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 21:07:10 INFO - Downloading https://queue.taskcluster.net/v1/task/J6QO1xH7RZ2hzApZg4ETiw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 21:07:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J6QO1xH7RZ2hzApZg4ETiw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 21:07:16 INFO - Downloaded 111259341 bytes. 21:07:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/J6QO1xH7RZ2hzApZg4ETiw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 21:07:16 INFO - mkdir: /builds/slave/test/properties 21:07:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:07:16 INFO - Writing to file /builds/slave/test/properties/build_url 21:07:16 INFO - Contents: 21:07:16 INFO - build_url:https://queue.taskcluster.net/v1/task/J6QO1xH7RZ2hzApZg4ETiw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 21:07:17 INFO - Running post-action listener: _resource_record_post_action 21:07:17 INFO - Running post-action listener: set_extra_try_arguments 21:07:17 INFO - [mozharness: 2016-08-17 04:07:17.462352Z] Finished download-and-extract step (success) 21:07:17 INFO - [mozharness: 2016-08-17 04:07:17.462471Z] Running populate-webroot step. 21:07:17 INFO - Running pre-action listener: _resource_record_pre_action 21:07:17 INFO - Running main action method: populate_webroot 21:07:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:07:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:07:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:07:17 INFO - '--tppagecycles', 21:07:17 INFO - '7'], 21:07:17 INFO - 'tests': ['tsvgm']}}, 21:07:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:07:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:07:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:07:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:07:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:07:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:07:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:07:17 INFO - 'talos_options': ['--disable-e10s'], 21:07:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:07:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:07:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:07:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:07:17 INFO - 'talos_options': ['--disable-e10s'], 21:07:17 INFO - 'tests': ['damp', 'tps']}, 21:07:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:07:17 INFO - 'tests': ['damp', 'tps']}, 21:07:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:07:17 INFO - 'tests': ['dromaeo_dom']}, 21:07:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:07:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:07:17 INFO - 'tests': ['basic_compositor_video']}, 21:07:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:07:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:07:17 INFO - 'tests': ['a11yr', 21:07:17 INFO - 'ts_paint', 21:07:17 INFO - 'tpaint', 21:07:17 INFO - 'sessionrestore', 21:07:17 INFO - 'sessionrestore_no_auto_restore', 21:07:17 INFO - 'tabpaint']}, 21:07:17 INFO - 'other-e10s': {'tests': ['a11yr', 21:07:17 INFO - 'ts_paint', 21:07:17 INFO - 'tpaint', 21:07:17 INFO - 'sessionrestore', 21:07:17 INFO - 'sessionrestore_no_auto_restore', 21:07:17 INFO - 'tabpaint']}, 21:07:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:07:17 INFO - 'ts_paint', 21:07:17 INFO - 'tpaint', 21:07:17 INFO - 'sessionrestore', 21:07:17 INFO - 'sessionrestore_no_auto_restore', 21:07:17 INFO - 'tabpaint']}, 21:07:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:07:17 INFO - 'ts_paint', 21:07:17 INFO - 'tpaint', 21:07:17 INFO - 'sessionrestore', 21:07:17 INFO - 'sessionrestore_no_auto_restore', 21:07:17 INFO - 'tabpaint']}, 21:07:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:07:17 INFO - 'tests': ['a11yr', 21:07:17 INFO - 'ts_paint', 21:07:17 INFO - 'tpaint', 21:07:17 INFO - 'sessionrestore', 21:07:17 INFO - 'sessionrestore_no_auto_restore', 21:07:17 INFO - 'tabpaint']}, 21:07:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:07:17 INFO - 'tests': ['a11yr', 21:07:17 INFO - 'ts_paint', 21:07:17 INFO - 'tpaint', 21:07:17 INFO - 'sessionrestore', 21:07:17 INFO - 'sessionrestore_no_auto_restore', 21:07:17 INFO - 'tabpaint']}, 21:07:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:07:17 INFO - 'tests': ['tsvgx', 21:07:17 INFO - 'tsvgr_opacity', 21:07:17 INFO - 'tart', 21:07:17 INFO - 'tscrollx', 21:07:17 INFO - 'cart']}, 21:07:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:07:17 INFO - 'tsvgr_opacity', 21:07:17 INFO - 'tart', 21:07:17 INFO - 'tscrollx', 21:07:17 INFO - 'cart']}, 21:07:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:07:17 INFO - 'talos_options': ['--disable-e10s'], 21:07:17 INFO - 'tests': ['tp5o']}, 21:07:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:07:17 INFO - 'tests': ['tp5o']}, 21:07:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:07:17 INFO - 'talos_options': ['--disable-e10s', 21:07:17 INFO - '--xperf_path', 21:07:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:07:17 INFO - 'tests': ['tp5n']}, 21:07:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:07:17 INFO - 'talos_options': ['--xperf_path', 21:07:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:07:17 INFO - 'tests': ['tp5n']}}, 21:07:17 INFO - 'talos.zip': {'path': '', 21:07:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:07:17 INFO - Running post-action listener: _resource_record_post_action 21:07:17 INFO - [mozharness: 2016-08-17 04:07:17.481369Z] Finished populate-webroot step (success) 21:07:17 INFO - [mozharness: 2016-08-17 04:07:17.481502Z] Running create-virtualenv step. 21:07:17 INFO - Running pre-action listener: _resource_record_pre_action 21:07:17 INFO - Running main action method: create_virtualenv 21:07:17 INFO - Creating virtualenv /builds/slave/test/build/venv 21:07:17 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 21:07:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:07:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:07:17 INFO - Using real prefix '/tools/python27' 21:07:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:07:18 INFO - Installing distribute.............................................................................................................................................................................................done. 21:07:21 INFO - Installing pip.................done. 21:07:21 INFO - Return code: 0 21:07:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:07:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:07:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:07:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:07:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:07:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:07:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:07:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fc7aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd0f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa600da92e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbded30>, '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 0x10f943db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbd6b20>, '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.v0eaMXJZvE/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.oL6OHIgTA7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 21:07:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:07:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:07:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v0eaMXJZvE/Render', 21:07:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:07:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:07:21 INFO - 'HOME': '/Users/cltbld', 21:07:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:07:21 INFO - 'LOGNAME': 'cltbld', 21:07:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:07:21 INFO - 'MOZ_NO_REMOTE': '1', 21:07:21 INFO - 'NO_EM_RESTART': '1', 21:07:21 INFO - 'PAGER': '/bin/cat', 21:07:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:07:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:07:21 INFO - 'PWD': '/builds/slave/test', 21:07:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:07:21 INFO - 'SHELL': '/bin/bash', 21:07:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oL6OHIgTA7/Listeners', 21:07:21 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 21:07:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:07:21 INFO - 'USER': 'cltbld', 21:07:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:07:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:07:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:07:21 INFO - 'XPC_FLAGS': '0x0', 21:07:21 INFO - 'XPC_SERVICE_NAME': '0', 21:07:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:07:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:07:21 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 21:07:21 INFO - Cleaning up... 21:07:21 INFO - Return code: 0 21:07:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:07:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:07:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:07:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:07:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:07:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:07:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:07:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10fc7aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd0f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa600da92e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbded30>, '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 0x10f943db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbd6b20>, '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.v0eaMXJZvE/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.oL6OHIgTA7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 21:07:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 21:07:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 21:07:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v0eaMXJZvE/Render', 21:07:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:07:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:07:21 INFO - 'HOME': '/Users/cltbld', 21:07:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:07:21 INFO - 'LOGNAME': 'cltbld', 21:07:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:07:21 INFO - 'MOZ_NO_REMOTE': '1', 21:07:21 INFO - 'NO_EM_RESTART': '1', 21:07:21 INFO - 'PAGER': '/bin/cat', 21:07:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:07:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:07:21 INFO - 'PWD': '/builds/slave/test', 21:07:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:07:21 INFO - 'SHELL': '/bin/bash', 21:07:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oL6OHIgTA7/Listeners', 21:07:21 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 21:07:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:07:21 INFO - 'USER': 'cltbld', 21:07:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:07:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:07:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:07:21 INFO - 'XPC_FLAGS': '0x0', 21:07:21 INFO - 'XPC_SERVICE_NAME': '0', 21:07:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:07:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:07:21 INFO - Downloading/unpacking psutil>=3.1.1 21:07:21 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 21:07:21 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 21:07:21 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 21:07:21 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 21:07:21 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 21:07:21 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 21:07:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:07:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:07:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:07:25 INFO - Installing collected packages: psutil 21:07:25 INFO - Running setup.py install for psutil 21:07:25 INFO - building 'psutil._psutil_osx' extension 21:07:25 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 21:07:25 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 21:07:26 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 21:07:26 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 21:07:26 INFO - building 'psutil._psutil_posix' extension 21:07:26 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 21:07:26 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:07:26 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:07:26 INFO - ^ 21:07:26 INFO - 1 warning generated. 21:07:26 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 21:07:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:07:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:07:26 INFO - Successfully installed psutil 21:07:26 INFO - Cleaning up... 21:07:26 INFO - Return code: 0 21:07:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:07:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:07:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:07:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:07:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:07:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:07:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:07:26 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 0x10fc7aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd0f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa600da92e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbded30>, '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 0x10f943db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbd6b20>, '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.v0eaMXJZvE/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.oL6OHIgTA7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 21:07:26 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 21:07:26 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 21:07:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v0eaMXJZvE/Render', 21:07:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:07:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:07:26 INFO - 'HOME': '/Users/cltbld', 21:07:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:07:26 INFO - 'LOGNAME': 'cltbld', 21:07:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:07:26 INFO - 'MOZ_NO_REMOTE': '1', 21:07:26 INFO - 'NO_EM_RESTART': '1', 21:07:26 INFO - 'PAGER': '/bin/cat', 21:07:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:07:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:07:26 INFO - 'PWD': '/builds/slave/test', 21:07:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:07:26 INFO - 'SHELL': '/bin/bash', 21:07:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oL6OHIgTA7/Listeners', 21:07:26 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 21:07:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:07:26 INFO - 'USER': 'cltbld', 21:07:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:07:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:07:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:07:26 INFO - 'XPC_FLAGS': '0x0', 21:07:26 INFO - 'XPC_SERVICE_NAME': '0', 21:07:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:07:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:07:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:07:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:07:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:07:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:07:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:07:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:07:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:07:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:07:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:07:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:07:29 INFO - Installing collected packages: mozsystemmonitor 21:07:29 INFO - Running setup.py install for mozsystemmonitor 21:07:29 INFO - Successfully installed mozsystemmonitor 21:07:29 INFO - Cleaning up... 21:07:29 INFO - Return code: 0 21:07:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:07:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:07:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:07:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:07:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:07:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:07:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:07:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fc7aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd0f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa600da92e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbded30>, '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 0x10f943db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbd6b20>, '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.v0eaMXJZvE/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.oL6OHIgTA7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 21:07:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 21:07:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 21:07:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v0eaMXJZvE/Render', 21:07:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:07:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:07:29 INFO - 'HOME': '/Users/cltbld', 21:07:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:07:29 INFO - 'LOGNAME': 'cltbld', 21:07:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:07:29 INFO - 'MOZ_NO_REMOTE': '1', 21:07:29 INFO - 'NO_EM_RESTART': '1', 21:07:29 INFO - 'PAGER': '/bin/cat', 21:07:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:07:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:07:29 INFO - 'PWD': '/builds/slave/test', 21:07:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:07:29 INFO - 'SHELL': '/bin/bash', 21:07:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oL6OHIgTA7/Listeners', 21:07:29 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 21:07:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:07:29 INFO - 'USER': 'cltbld', 21:07:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:07:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:07:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:07:29 INFO - 'XPC_FLAGS': '0x0', 21:07:29 INFO - 'XPC_SERVICE_NAME': '0', 21:07:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:07:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:07:29 INFO - Downloading/unpacking jsonschema==2.5.1 21:07:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:07:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:07:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:07:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:07:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:07:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:07:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:07:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:07: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 21:07: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 21:07: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 21:07: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 21:07: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 21:07: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 21:07:32 INFO - Downloading functools32-3.2.3-2.tar.gz 21:07:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:07:32 INFO - warning: no files found matching '*.txt' 21:07:32 INFO - no previously-included directories found matching 'build' 21:07:32 INFO - no previously-included directories found matching 'dist' 21:07:32 INFO - no previously-included directories found matching '.git*' 21:07:32 INFO - Installing collected packages: jsonschema, functools32 21:07:32 INFO - Running setup.py install for functools32 21:07:32 INFO - warning: no files found matching '*.txt' 21:07:32 INFO - no previously-included directories found matching 'build' 21:07:32 INFO - no previously-included directories found matching 'dist' 21:07:32 INFO - no previously-included directories found matching '.git*' 21:07:32 INFO - Successfully installed jsonschema functools32 21:07:32 INFO - Cleaning up... 21:07:32 INFO - Return code: 0 21:07:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:07: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')]} 21:07:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:07:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:07: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')]} 21:07:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:07:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:07: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', '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 0x10fc7aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd0f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa600da92e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbded30>, '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 0x10f943db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbd6b20>, '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.v0eaMXJZvE/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.oL6OHIgTA7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 21:07: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:07: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 functools32==3.2.3-2 21:07:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v0eaMXJZvE/Render', 21:07:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:07:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:07:32 INFO - 'HOME': '/Users/cltbld', 21:07:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:07:32 INFO - 'LOGNAME': 'cltbld', 21:07:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:07:32 INFO - 'MOZ_NO_REMOTE': '1', 21:07:32 INFO - 'NO_EM_RESTART': '1', 21:07:32 INFO - 'PAGER': '/bin/cat', 21:07:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:07:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:07:32 INFO - 'PWD': '/builds/slave/test', 21:07:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:07:32 INFO - 'SHELL': '/bin/bash', 21:07:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oL6OHIgTA7/Listeners', 21:07:32 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 21:07:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:07:32 INFO - 'USER': 'cltbld', 21:07:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:07:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:07:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:07:32 INFO - 'XPC_FLAGS': '0x0', 21:07:32 INFO - 'XPC_SERVICE_NAME': '0', 21:07:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:07:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:07:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:07:33 INFO - Cleaning up... 21:07:33 INFO - Return code: 0 21:07:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:07:33 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')]} 21:07:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:07:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:07:33 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')]} 21:07:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:07:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:07:33 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 0x10fc7aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd0f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa600da92e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbded30>, '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 0x10f943db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbd6b20>, '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.v0eaMXJZvE/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.oL6OHIgTA7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 21:07:33 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 21:07:33 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 21:07:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v0eaMXJZvE/Render', 21:07:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:07:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:07:33 INFO - 'HOME': '/Users/cltbld', 21:07:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:07:33 INFO - 'LOGNAME': 'cltbld', 21:07:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:07:33 INFO - 'MOZ_NO_REMOTE': '1', 21:07:33 INFO - 'NO_EM_RESTART': '1', 21:07:33 INFO - 'PAGER': '/bin/cat', 21:07:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:07:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:07:33 INFO - 'PWD': '/builds/slave/test', 21:07:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:07:33 INFO - 'SHELL': '/bin/bash', 21:07:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oL6OHIgTA7/Listeners', 21:07:33 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 21:07:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:07:33 INFO - 'USER': 'cltbld', 21:07:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:07:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:07:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:07:33 INFO - 'XPC_FLAGS': '0x0', 21:07:33 INFO - 'XPC_SERVICE_NAME': '0', 21:07:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:07:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:07:33 INFO - Downloading/unpacking blobuploader==1.2.4 21:07:33 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 21:07:33 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 21:07:33 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 21:07:33 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 21:07:33 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 21:07:33 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 21:07:35 INFO - Downloading blobuploader-1.2.4.tar.gz 21:07:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:07:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:07:35 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 21:07:35 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 21:07:35 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 21:07:35 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 21:07:35 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 21:07:35 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 21:07:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:07:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:07:36 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 21:07:36 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 21:07:36 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 21:07:36 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 21:07:36 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 21:07:36 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 21:07:37 INFO - Downloading docopt-0.6.1.tar.gz 21:07:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:07:37 INFO - Installing collected packages: blobuploader, requests, docopt 21:07:37 INFO - Running setup.py install for blobuploader 21:07:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:07:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:07:37 INFO - Running setup.py install for requests 21:07:37 INFO - Running setup.py install for docopt 21:07:38 INFO - Successfully installed blobuploader requests docopt 21:07:38 INFO - Cleaning up... 21:07:38 INFO - Return code: 0 21:07:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:07:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:07:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:07:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:07:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:07:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:07:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:07:38 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 0x10fc7aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd0f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa600da92e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbded30>, '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 0x10f943db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbd6b20>, '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.v0eaMXJZvE/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.oL6OHIgTA7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 21:07:38 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 21:07:38 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 21:07:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v0eaMXJZvE/Render', 21:07:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:07:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:07:38 INFO - 'HOME': '/Users/cltbld', 21:07:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:07:38 INFO - 'LOGNAME': 'cltbld', 21:07:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:07:38 INFO - 'MOZ_NO_REMOTE': '1', 21:07:38 INFO - 'NO_EM_RESTART': '1', 21:07:38 INFO - 'PAGER': '/bin/cat', 21:07:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:07:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:07:38 INFO - 'PWD': '/builds/slave/test', 21:07:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:07:38 INFO - 'SHELL': '/bin/bash', 21:07:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oL6OHIgTA7/Listeners', 21:07:38 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 21:07:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:07:38 INFO - 'USER': 'cltbld', 21:07:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:07:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:07:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:07:38 INFO - 'XPC_FLAGS': '0x0', 21:07:38 INFO - 'XPC_SERVICE_NAME': '0', 21:07:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:07:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:07:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:07:38 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-XEanO3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:07:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:07:38 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-1MqJQ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:07:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:07:38 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-VT2PlZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:07:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:07:38 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-kX98CE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:07:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:07:38 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-RqO1dZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:07:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:07:38 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-qmLW11-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:07:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:07:38 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-ypd3gW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:07:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:07:39 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-yExxho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:07:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:07:39 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-tbSPan-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:07:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:07:39 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-X8ZRRC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:07:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:07:39 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-dUL5Rq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:07:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:07:39 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-sdwEzB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:07:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:07:39 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-ZxlRO_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:07:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:07:39 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-UjKwx1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:07:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:07:39 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-5Xdnd_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:07:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:07:39 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-X96Reh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:07:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:07:40 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-3dkPk9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:07:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:07:40 INFO - Running setup.py install for manifestparser 21:07:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:07:40 INFO - Running setup.py install for mozcrash 21:07:40 INFO - Running setup.py install for mozdebug 21:07:40 INFO - Running setup.py install for mozdevice 21:07:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:07:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:07:40 INFO - Running setup.py install for mozfile 21:07:40 INFO - Running setup.py install for mozhttpd 21:07:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:07:41 INFO - Running setup.py install for mozinfo 21:07:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:07:41 INFO - Running setup.py install for mozInstall 21:07:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:07:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:07:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:07:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:07:41 INFO - Running setup.py install for mozleak 21:07:41 INFO - Running setup.py install for mozlog 21:07:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:07:41 INFO - Running setup.py install for moznetwork 21:07:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:07:41 INFO - Running setup.py install for mozprocess 21:07:41 INFO - Running setup.py install for mozprofile 21:07:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:07:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:07:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:07:42 INFO - Running setup.py install for mozrunner 21:07:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:07:42 INFO - Running setup.py install for mozscreenshot 21:07:42 INFO - Running setup.py install for moztest 21:07:42 INFO - Running setup.py install for mozversion 21:07:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:07:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:07:42 INFO - Cleaning up... 21:07:42 INFO - Return code: 0 21:07:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:07:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:07:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:07:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:07:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:07:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:07:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:07:42 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 0x10fc7aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd0f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa600da92e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbded30>, '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 0x10f943db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbd6b20>, '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.v0eaMXJZvE/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.oL6OHIgTA7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 21:07:42 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 21:07:42 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 21:07:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v0eaMXJZvE/Render', 21:07:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:07:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:07:42 INFO - 'HOME': '/Users/cltbld', 21:07:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:07:42 INFO - 'LOGNAME': 'cltbld', 21:07:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:07:42 INFO - 'MOZ_NO_REMOTE': '1', 21:07:42 INFO - 'NO_EM_RESTART': '1', 21:07:42 INFO - 'PAGER': '/bin/cat', 21:07:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:07:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:07:42 INFO - 'PWD': '/builds/slave/test', 21:07:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:07:42 INFO - 'SHELL': '/bin/bash', 21:07:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oL6OHIgTA7/Listeners', 21:07:42 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 21:07:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:07:42 INFO - 'USER': 'cltbld', 21:07:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:07:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:07:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:07:42 INFO - 'XPC_FLAGS': '0x0', 21:07:42 INFO - 'XPC_SERVICE_NAME': '0', 21:07:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:07:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:07:43 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-c0n_9c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:07:43 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)) 21:07:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:07:43 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-Byb8ty-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:07:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 21:07:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:07:43 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-0lm_L6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:07:43 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)) 21:07:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:07:43 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-YyQGCF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:07:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 21:07:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:07:43 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-yZ937m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:07:43 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)) 21:07:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:07:43 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-iigoKr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:07:43 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)) 21:07:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:07:43 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-EZ2ntU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:07:43 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)) 21:07:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:07:43 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-AOC3gs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:07:43 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)) 21:07:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:07:43 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-RHEyu1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:07:43 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)) 21:07:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:07:43 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-Fvahjq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:07:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 21:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:07:44 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-MvWh_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:07:44 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)) 21:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:07:44 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-b9Ak0C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:07:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 21:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:07:44 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-APl82G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:07:44 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)) 21:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:07:44 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-g1Qi2q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:07:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 21:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:07:44 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-0IVK1d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:07:44 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)) 21:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:07:44 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-fnDneh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:07:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 21:07:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:07:44 INFO - Running setup.py (path:/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/pip-K9Svyb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:07:44 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)) 21:07:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:07:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:07:44 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)) 21:07:44 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:07:44 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:07:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:07: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 21:07: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 21:07: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 21:07: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 21:07: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 21:07: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 21:07:47 INFO - Downloading blessings-1.6.tar.gz 21:07:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:07:47 INFO - Installing collected packages: blessings 21:07:47 INFO - Running setup.py install for blessings 21:07:47 INFO - Successfully installed blessings 21:07:47 INFO - Cleaning up... 21:07:47 INFO - Return code: 0 21:07:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:07:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:07:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:07:47 INFO - Reading from file tmpfile_stdout 21:07:47 INFO - Current package versions: 21:07:47 INFO - blessings == 1.6 21:07:47 INFO - blobuploader == 1.2.4 21:07:47 INFO - docopt == 0.6.1 21:07:47 INFO - functools32 == 3.2.3-2 21:07:47 INFO - jsonschema == 2.5.1 21:07:47 INFO - manifestparser == 1.1 21:07:47 INFO - mozInstall == 1.12 21:07:47 INFO - mozcrash == 0.17 21:07:47 INFO - mozdebug == 0.1 21:07:47 INFO - mozdevice == 0.48 21:07:47 INFO - mozfile == 1.2 21:07:47 INFO - mozhttpd == 0.7 21:07:47 INFO - mozinfo == 0.9 21:07:47 INFO - mozleak == 0.1 21:07:47 INFO - mozlog == 3.3 21:07:47 INFO - moznetwork == 0.27 21:07:47 INFO - mozprocess == 0.23 21:07:47 INFO - mozprofile == 0.28 21:07:47 INFO - mozrunner == 6.12 21:07:47 INFO - mozscreenshot == 0.1 21:07:47 INFO - mozsystemmonitor == 0.3 21:07:47 INFO - moztest == 0.7 21:07:47 INFO - mozversion == 1.4 21:07:47 INFO - psutil == 3.1.1 21:07:47 INFO - requests == 1.2.3 21:07:47 INFO - wsgiref == 0.1.2 21:07:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:07: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')]} 21:07:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:07:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:07: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')]} 21:07:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:07:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:07:47 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 0x10fc7aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd0f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa600da92e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbded30>, '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 0x10f943db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbd6b20>, '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.v0eaMXJZvE/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.oL6OHIgTA7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 21:07:47 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 21:07:47 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 21:07:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v0eaMXJZvE/Render', 21:07:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:07:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:07:47 INFO - 'HOME': '/Users/cltbld', 21:07:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:07:47 INFO - 'LOGNAME': 'cltbld', 21:07:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:07:47 INFO - 'MOZ_NO_REMOTE': '1', 21:07:47 INFO - 'NO_EM_RESTART': '1', 21:07:47 INFO - 'PAGER': '/bin/cat', 21:07:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:07:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:07:47 INFO - 'PWD': '/builds/slave/test', 21:07:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:07:47 INFO - 'SHELL': '/bin/bash', 21:07:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oL6OHIgTA7/Listeners', 21:07:47 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 21:07:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:07:47 INFO - 'USER': 'cltbld', 21:07:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:07:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:07:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:07:47 INFO - 'XPC_FLAGS': '0x0', 21:07:47 INFO - 'XPC_SERVICE_NAME': '0', 21:07:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:07:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:07:48 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)) 21:07:48 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)) 21:07:48 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)) 21:07:48 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)) 21:07:48 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)) 21:07:48 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)) 21:07:48 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)) 21:07:48 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)) 21:07:48 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)) 21:07:48 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)) 21:07:48 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)) 21:07:48 INFO - Cleaning up... 21:07:48 INFO - Return code: 0 21:07:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:07:48 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')]} 21:07:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:07:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:07:48 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')]} 21:07:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:07:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:07:48 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 0x10fc7aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd0f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa600da92e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbded30>, '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 0x10f943db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbd6b20>, '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.v0eaMXJZvE/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.oL6OHIgTA7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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 21:07:48 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 21:07:48 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 21:07:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v0eaMXJZvE/Render', 21:07:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:07:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:07:48 INFO - 'HOME': '/Users/cltbld', 21:07:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:07:48 INFO - 'LOGNAME': 'cltbld', 21:07:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:07:48 INFO - 'MOZ_NO_REMOTE': '1', 21:07:48 INFO - 'NO_EM_RESTART': '1', 21:07:48 INFO - 'PAGER': '/bin/cat', 21:07:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:07:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:07:48 INFO - 'PWD': '/builds/slave/test', 21:07:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:07:48 INFO - 'SHELL': '/bin/bash', 21:07:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oL6OHIgTA7/Listeners', 21:07:48 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 21:07:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:07:48 INFO - 'USER': 'cltbld', 21:07:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:07:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:07:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:07:48 INFO - 'XPC_FLAGS': '0x0', 21:07:48 INFO - 'XPC_SERVICE_NAME': '0', 21:07:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:07:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:07:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:07:48 INFO - Cleaning up... 21:07:48 INFO - Return code: 0 21:07:48 INFO - Running post-action listener: _resource_record_post_action 21:07:48 INFO - Running post-action listener: _start_resource_monitoring 21:07:48 INFO - Starting resource monitoring. 21:07:48 INFO - [mozharness: 2016-08-17 04:07:48.535979Z] Finished create-virtualenv step (success) 21:07:48 INFO - [mozharness: 2016-08-17 04:07:48.536947Z] Running install step. 21:07:48 INFO - Running pre-action listener: _resource_record_pre_action 21:07:48 INFO - Running main action method: install 21:07:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:07:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:07:48 INFO - Reading from file tmpfile_stdout 21:07:48 INFO - Detecting whether we're running mozinstall >=1.0... 21:07:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:07:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:07:48 INFO - Reading from file tmpfile_stdout 21:07:48 INFO - Output received: 21:07:48 INFO - Usage: mozinstall [options] installer 21:07:48 INFO - Options: 21:07:48 INFO - -h, --help show this help message and exit 21:07:48 INFO - -d DEST, --destination=DEST 21:07:48 INFO - Directory to install application into. [default: 21:07:48 INFO - "/builds/slave/test"] 21:07:48 INFO - --app=APP Application being installed. [default: firefox] 21:07:48 INFO - mkdir: /builds/slave/test/build/application 21:07:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 21:07:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 21:08:22 INFO - Reading from file tmpfile_stdout 21:08:22 INFO - Output received: 21:08:22 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 21:08:22 INFO - Running post-action listener: _resource_record_post_action 21:08:22 INFO - [mozharness: 2016-08-17 04:08:22.941705Z] Finished install step (success) 21:08:22 INFO - [mozharness: 2016-08-17 04:08:22.941847Z] Running run-tests step. 21:08:22 INFO - Running pre-action listener: _resource_record_pre_action 21:08:22 INFO - Running main action method: run_tests 21:08:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:08:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:08:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:08:22 INFO - 2016-08-16 21:08:22.956 screenresolution[1634:8098] starting screenresolution argv=screenresolution get 21:08:22 INFO - 2016-08-16 21:08:22.958 screenresolution[1634:8098] Display 0: 1600x1200x32@60 21:08:22 INFO - 2016-08-16 21:08:22.965 screenresolution[1635:8100] starting screenresolution argv=screenresolution list 21:08:22 INFO - Available Modes on Display 0 21:08:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:08:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:08:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:08:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:08:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:08:23 INFO - Intel Iris: 21:08:23 INFO - Chipset Model: Intel Iris 21:08:23 INFO - Type: GPU 21:08:23 INFO - Bus: Built-In 21:08:23 INFO - VRAM (Dynamic, Max): 1536 MB 21:08:23 INFO - Vendor: Intel (0x8086) 21:08:23 INFO - Device ID: 0x0a2e 21:08:23 INFO - Revision ID: 0x0009 21:08:23 INFO - Displays: 21:08:23 INFO - Display: 21:08:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:08:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:08:23 INFO - Display Serial Number: 1600x1200 60 21:08:23 INFO - Main Display: Yes 21:08:23 INFO - Mirror: Off 21:08:23 INFO - Online: Yes 21:08:23 INFO - Rotation: Supported 21:08:23 INFO - Return code: 0 21:08:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:08:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:08:23 INFO - Python 2.7.3 21:08:23 INFO - Return code: 0 21:08:23 INFO - grabbing minidump binary from tooltool 21:08:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:08:23 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 0x10fbded30>, '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 0x10f943db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbd6b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:08:23 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 21:08:23 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 21:08:23 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 21:08:23 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:08:23 INFO - Return code: 0 21:08:23 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 21:08:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:08:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:08:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 21:08:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:08:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/J6QO1xH7RZ2hzApZg4ETiw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0165', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 21:08:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/J6QO1xH7RZ2hzApZg4ETiw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0165 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 21:08:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v0eaMXJZvE/Render', 21:08:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:08:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:08:23 INFO - 'HOME': '/Users/cltbld', 21:08:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:08:23 INFO - 'LOGNAME': 'cltbld', 21:08:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:08:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 21:08:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:08:23 INFO - 'MOZ_NO_REMOTE': '1', 21:08:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:08:23 INFO - 'NO_EM_RESTART': '1', 21:08:23 INFO - 'PAGER': '/bin/cat', 21:08:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:08:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:08:23 INFO - 'PWD': '/builds/slave/test', 21:08:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:08:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:08:23 INFO - 'SHELL': '/bin/bash', 21:08:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oL6OHIgTA7/Listeners', 21:08:23 INFO - 'TMPDIR': '/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/', 21:08:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:08:23 INFO - 'USER': 'cltbld', 21:08:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:08:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:08:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:08:23 INFO - 'XPC_FLAGS': '0x0', 21:08:23 INFO - 'XPC_SERVICE_NAME': '0', 21:08:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:08:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/J6QO1xH7RZ2hzApZg4ETiw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0165', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 21:08:23 INFO - mozversion application_buildid: 20160816184915 21:08:23 INFO - mozversion application_changeset: fe895421dfbe1f1f8f1fc6a39bb20774423a6d74 21:08:23 INFO - mozversion application_display_name: Nightly 21:08:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:08:23 INFO - mozversion application_name: Firefox 21:08:23 INFO - mozversion application_remotingname: firefox 21:08:23 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 21:08:23 INFO - mozversion application_vendor: Mozilla 21:08:23 INFO - mozversion application_version: 51.0a1 21:08:23 INFO - mozversion platform_buildid: 20160816184915 21:08:23 INFO - mozversion platform_changeset: fe895421dfbe1f1f8f1fc6a39bb20774423a6d74 21:08:23 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 21:08:23 INFO - mozversion platform_version: 51.0a1 21:08:23 INFO - using testdate: 1471406903 21:08:23 INFO - actual date: 1471406903 21:08:23 INFO - starting webserver on 'localhost:49274' 21:08:23 INFO - SUITE-START | Running 2 tests 21:08:23 INFO - TEST-START | dromaeo_css 21:08:23 INFO - operating with platform_type : mac_ 21:08:23 INFO - Initialising browser for dromaeo_css test... 21:08:23 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/tmpJcao7h/profile http://localhost:49274/getInfo.html) 21:08:25 INFO - PROCESS | 1645 | __metrics Screen width/height:1600/1200 21:08:25 INFO - PROCESS | 1645 | colorDepth:24 21:08:25 INFO - PROCESS | 1645 | Browser inner width/height: 1024/689 21:08:25 INFO - PROCESS | 1645 | __metrics 21:08:25 INFO - PROCESS | 1645 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:08:25 INFO - PROCESS | 1645 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:08:26 INFO - TEST-INFO | 1645: exit 0 21:08:26 INFO - Browser initialized. 21:08:26 INFO - Running cycle 1/1 for dromaeo_css test... 21:08:26 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/tmpJcao7h/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:08:38 INFO - PROCESS | 1648 | RSS: Main: 228130816 21:08:38 INFO - PROCESS | 1648 | 21:09:30 INFO - PROCESS | 1648 | 1471406970377 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 21:11:41 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 21:11:42 INFO - PROCESS | 1648 | RSS: Main: 364597248 21:11:42 INFO - PROCESS | 1648 | 21:14:46 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 21:14:46 INFO - PROCESS | 1648 | RSS: Main: 375382016 21:14:46 INFO - PROCESS | 1648 | 21:17:49 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 21:17:49 INFO - PROCESS | 1648 | RSS: Main: 336211968 21:17:49 INFO - PROCESS | 1648 | 21:20:52 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 21:20:52 INFO - PROCESS | 1648 | RSS: Main: 345137152 21:20:52 INFO - PROCESS | 1648 | 21:23:56 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 21:23:57 INFO - PROCESS | 1648 | RSS: Main: 331063296 21:23:57 INFO - PROCESS | 1648 | 21:27:00 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 21:27:00 INFO - PROCESS | 1648 | RSS: Main: 487948288 21:27:00 INFO - PROCESS | 1648 | 21:27:00 INFO - PROCESS | 1648 | __start_tp_report 21:27:00 INFO - PROCESS | 1648 | _x_x_mozilla_page_load 21:27:00 INFO - PROCESS | 1648 | _x_x_mozilla_page_load_details 21:27:00 INFO - PROCESS | 1648 | |i|pagename|runs| 21:27:00 INFO - PROCESS | 1648 | |0;dojo.html;2832.886684532619;3158.968410315897;3333.4166520858844;3369.8315084245787;3378.0879162626075;5494.780208791643;5611.915821262679;5613.354464236614;5652.5195358394585;5670.8582285442835;5638.548916086703;5651.717414129298;5756.251687280658;5766.740496677649;5804.361520232771;5100.69395836251;5135.306733590974;5173.870653233662;5183.429822719498;5260.316158899338;5255.500727430888;5274.841754747364;5279.2872962150195;5294.047071527124;5313.548348390372;5043.5965122790085;5126.128558145124;5132.615053870937;5166.328377310963;5184.637075404742;5147.665401748912;5171.974140129275;5177.844664660066;5178.689278643294;5179.8446046618665;5088.542031217171;5091.516305950966;5108.616853735947;5136.280920671109;5147.0992576298995;5548.889022219533;5678.375378708339;5685.204071430003;5695.743691533849;5699.287589051369;6011.30869949957;6079.6960151992225;6202.565820392574;6210.441060304549;6212.285587157489;6170.629762214281;6200.379962003809;6256.436920677115;6263.71813268404;6301;5794.391588883191;5801.680907550083;5809.9419005809405;5810.82567522975;5823.912641310384;6195.96902015487;6231.844203894939;6255.093011513305;6306.747730090745;6313.621182729051;6081.422264884829;6123.964183031302;6134.141220229171;6140.105498721277;6146.784862529879;6215.192025036717;6228.128062071313;6244.12582238487;6245.781397651061;6246;6008.098785182257;6054.424829641177;6176.826402983419;6182.876342473215;6212.192414986113;6128.877422451526;6130.707930599209;6134.987697083657;6178.474829639441;6215.285242197115;4847.636427267969;4848.490908454632;4865.197242454955;4869.952960113593;4915.877103072452;4357.4988876279;4372.934405983913;4409.426774519292;4426.712263702849;4459.888502787457;4754.548317909793;5591.6365436246515;5641.041023026095;5644.8306550803545;5671.120976248688;4939.753012349368;6152.169457123231;6228.844278892973;6303.558750887394;6305.085762564494;5695.971520142372;5729.684867332337;5747.195392645033;5757.884842303214;5762.596618236767;5328.573714102862;5365.061114304981;5369.140937449989;5369.973150134302;5370.543503802142;6233.594816336924;6239.313675495692;6250.9062364064575;6269.749210031548;6292.182016337847;6256.155419018374;6261;6263.96868015657;6274.560780745304;6283.37166283368;6173.536984726074;6269.185005949197;6297.181366422519;6312.5581209314905;6314.147590075465;5985.281766188085;6074.210352654127;6089;6089.056196289582;6159.922013647683;6217.160683307696;6223.159873417031;6231.7818876340925;6243.937560624518;6266.342034086355;6038.607490513278;6069.696515174312;6070.817875463743;6073.48375388097;6079.3312735598165;4835.854924352275;5359.820839415323;5958.76164953397;5997.31030931431;6013.909791353046;4463.598276155161;5825.76696932118;5848.590598658053;5951.613145145551;5955.731992060281;6045.365236650088;6073.180120683828;6078.72645730952;6080.604760690541;6094.54290928191;5714.342850572071;5804.042333015174;5851.502622277154;5853.824385268449;5946.316173640087 21:27:00 INFO - PROCESS | 1648 | |1;ext.html;475.2609691929049;476.0787875460982;480.79085597764976;533.3839415475128;544.3875639905107;30406.695933040664;33847.98456046316;39871.40192897109;41211;43381.34927976075;40876;41362.37956430649;41381;41547.376789348185;41674.79162604183;9609.135177833994;9795.06946840049;9814.312998090136;9819.852702209473;9843.212542996578;8690.695825646104;8922.553872306391;11726.8240976385;11994.280343179393;12023.398830058506;11956.880431195706;12019.7596048079;12031.699207519794;12034.69913252167;12056.879431205707;11786.116041296895;11896.464659090361;11898.405079745979;11914.046876249879;11915.523379064827;11629.185956983014;11710.414479276087;11719.882801171965;11812.586559470463;11828.172027958046;39435.60564394348;39726.40410393846;39749.40375894364;39806.80096599498;39869.00327491807;3391.491276308549;3442.9483557746653;3463.9826800866085;3464.566929133858;3579.534660494119;30158.547621785692;31248.21879453009;31391.686083139106;31446.899358522343;31571.21071973196;3179.4118088153537;3207.695268949446;3247.382997230519;3317.170707323169;3317.5853018372704;451366;455920;460081;460715;466997.66501167614;56246.71876640591;56322.7183864078;56545.628165324226;56592.43407565954;56704.71647641818;49484.257736133986;59730.10404843931;59815.401845981854;59867.802643946874;59887;16121.838781612034;16352.264148113363;16354.018758874505;16378.590535236714;16385;11483.368414737102;11842.407879605986;12909.677258068623;12951.611451656465;13025.413856376295;14903.478378256708;15332.923335383251;15333.156676382907;15575.922120389325;15776.68446631061;6115.755369785159;6269.498440124779;6523.988781738838;6601.3728695773825;6626.204855417284;744.8435828475972;948.393028461785;954.8854137503405;1025.3181634213165;1063.9202059845543;27210.727892721214;28036.71963280341;28673.71326286752;28958.175511343095;29003.12990610285;949.2263804998904;969.2439896880445;1034.4000479721744;1073.6939972108069;1093.1855767453299;13729.862701373058;14947.775783363259;15052.021618594756;15179.628602688774;15313.923430382776;568305;572263.277367221;577215;583967;585373;57986.71006645024;58098.54753631108;58183.41816581865;58377.416225838046;58479;1224.1002862895764;1342.201390172826;1374.8075269462283;1387.3964825301027;1403.7683782176234;29992.700072998992;30889.382212356075;30892;31526.054218373487;31683.683163168072;48145;48573.51426485831;48581.514184859116;48636.75681621569;48780;476644;478224;481168.18831811234;485428;486592;23800.40498987539;24306.392340191636;24338.756612433648;24381.878090610142;24471;46319.3052104212;46538.53461465342;46783.76608116938;47217.29174062323;48019;34358.969230922114;38507;38676.41985370278;38720;39759;32295;38184.236315274095;38330.80834595809;39107.6089239104;39395;37865.62134378621;38375.80812096033;38828.6117138825;38921;39307.01732456712;31604.841975789976;34308.31383372368;34373;34532.6474396469;34543.163957046534;22131.4507984446;23568;25354.873225633753;25844.612330815427;25906.04161042933 21:27:00 INFO - PROCESS | 1648 | |2;jquery.html;356.64335664335664;374.1152175105874;377.5865427357044;384.5961740172818;408.0614586451163;15480.535583932471;15771.369145234192;20475.590488190246;20870.58258834826;20929.05819238134;20829.47926301843;21073.683894741593;21437.67843482349;21559;22061.448463788372;5153.665011774241;5905.557083218765;6015.488683461911;6094.421030002165;6141.508679305667;4192.958070419288;5941.673207973559;6077.39226077391;6129.233845769279;6152;4400.7579583122915;6368.10846481493;6664.733410663568;6720;6788.321167883197;6604.174478190226;6683.431908287801;6726.327367263283;6740.191177058784;6741.056252124682;5831.562632802515;5833.941660583425;5836.503897168745;5837.854053648693;5842.123681447774;25635.871820640776;26256.868715656492;26437.73562264391;27160.45679086427;27543.586846197322;2245.113180293791;2272.863628182314;2303.884805759705;2316.455632926261;2474.7277799442045;15568.922155389264;15748.685026299525;16025.278862451218;16164.838351616569;16615.252313645917;1622.9937438787908;1830.1489807239564;1835.5502901789014;1875.22178296007;1949.727038214651;105022;123372;123687;123949;155826.40517124953;15606.375744970073;20640.69038964417;21203.879612038672;21548.35354939354;21588.56822863534;34715.30569388598;35187.82406087953;35246.766363177165;35305.293894121976;35480;9494.667686631074;11169.888301116885;11282.830757538644;11325.71685707864;11553.191276610725;9314.394564353295;9326.393784403992;9343.953280233556;9532;9538;8100.270975612223;9343.392679475812;9735.318527702993;9862;9885.604575816888;3147.0960069158286;3593.4789455528803;3695.3902606070237;3697.759645623026;3831.5402151741414;802.7631848604676;843.0305149078487;878.4509681449094;914.9542522873829;957.7318350861769;16720.832791672172;20495.590088198154;20511;21034.78965210359;21148;783.6356094416124;887.2369762004671;892.4779004282437;922.8846394200725;929.5398777604994;10626.787464250672;11190.104791616652;11190.32858028521;11240.943795280971;11418.02946749519;571537;586760;588396;602653;604472;132024;143322.28338858238;145754;145903;147756.7916170891;984.5618699678574;1005.5877090392904;1025.733309339562;1028.3058935218548;1031.9845202321972;19002.1449034791;19412.902935485232;19602.90198548998;19780.01099944968;19836.801631983497;50800.96796128114;57028.71485642711;57882.710586446796;59002;59680.70159649174;82185.76721349065;85175.574122129;86622;86700;87512.5624371874;7946.125926148235;7972.441929064909;7992.680292788224;8212.876806847782;8463.49219046859;9397.154256116983;12714.364281785689;13034.869651303365;13354.866451335361;13413.32933353348;10995.615153469591;11140.498677559368;11286.774264514499;11297.491612877604;11340.886591133984;6407.71165297572;10916.454177291262;11043.39261340634;11258.83111753308;11325.263857849213;11490.316897027224;11562.595309164139;11615.76768464643;11776.234544754563;11798.941005294919;5845.795397161079;7881.448298619041;7887.84224315522;8160.632771525177;8256.091829898827;8996.595153218252;11121.721956951142;11221.438928053401;11337.886621134014;11636.243644163102 21:27:00 INFO - PROCESS | 1648 | |3;mootools.html;1355.6610847288177;1531.9387224511017;1562.6405926636871;1647.8187399386065;1817.9545511362205;7480.13978392485;8364.456310339823;8720.5639718014;8722.563871806417;8823.16179962904;8606.87089693655;8714.564271786401;8722.302215822734;8749.343799215068;8774.210321071103;2360.551495215908;2388.199953015742;2391.0555330644384;2391.2587097999676;2404.651325557793;1993.8236440500102;2306.8615883046987;2374.03851440167;2375.0974629640714;2381.249906279525;2105.6420408530585;2250.4711392822674;2358.7287461941924;2371.087131454394;2375.1449478187837;2310.780475854791;2338.684277622525;2342.332435255944;2346.495503466746;2358.25714899806;2340.0873659272897;2346.366481050124;2354.9175778847657;2364.3261670423844;2368.39605900496;7790.805229869242;8583.399162058658;8729.956350218208;8761.51811650359;8772.73681789541;5110.770015349318;5311.256424100629;5312.150055991062;5314.7608357624;5314.946850531523;3588.5873124590744;3630.2739452109417;3646.0702520857276;3694.3534881395917;3696.075981004749;976.4190306767462;1078.7141407527013;1083.6748975307376;1091.3615534912085;1102.597551893561;11499.59751408705;11540.365279909602;11600.709982250426;11613.30320180792;11683.12376571752;4366.454193225847;4488.1248156609145;4605.447346318463;4610.76946152691;4630.189716799547;9183.816323673489;9184.724458266262;9184.954075229582;9198.862017069749;9218.53907304632;5251.238570407269;5252.29094072303;5252.395974462986;5255.605829562798;5258.501327121752;3970.6029397060065;4390.538993405647;4401.2517871961845;4541.84103556374;4941.258811178352;3740.831662575191;3785.242951409729;3791.5071040764524;3836.1368692044066;3864.555576108727;1155.8959693627614;1165.6619580321612;1170.2042611024415;1178.5816035307514;1181.474243961429;813.4875028731861;892.6250974590688;923.8891333039944;954.6897258391051;957.8888489352457;5800.970995144998;6094.695265236809;6107.84730381744;6181.690915454209;6409.583377080475;700.9719611215494;919.434547753127;928.0441145620022;941.5104145844259;958.3674774648698;3803.82882770276;4020.6073430964666;4052.513698356216;4098.323776576832;4130.235906357333;10460.215483838743;10739.463026848627;10850.077743391743;10856.78286434267;10856.945715271373;10806.675799726021;10807.027367536959;10807.891921080689;10821.350718956888;10829.67510974672;7595.430342724318;7992.400569957276;8061.596920154087;8205.261526462647;8206.753797386087;5895.659903420269;6070.028795392716;6094.939050609437;6167.488965203554;6213.099100630474;8358.5402802844;10192.286539942133;10198.184145268213;10198.898011019795;10207.489625518843;9221.077892210993;9874.605015799287;10186.745331366776;10330.586776529155;10407.21945854079;6076.605020673642;7447.81380465471;7559.092908850753;7644.808879777827;7666.616669166631;8223.342132629496;8223.79440513968;8274.172582741678;8310.252077313071;8328.833423331378;7467.141278753013;7469.290417410337;7526.209747976383;7550.962245188739;7579.090509138939;6408.391202835724;7164.462665300019;7209.6034718091005;7297.781066568012;7544.094708634999;6977.616231107338;7009.018737376873;7077.6461176941975;7092.787216383516;7092.858142837217;4857.417109946829;4883.462819089827;4926.3842019747535;5001.524855138756;5014.72419016943;5065.316182315488;5123.38519377677;5190.169572868323;5203.840406231371;5225.294585230945 21:27:00 INFO - PROCESS | 1648 | |4;prototype.html;293.5948391220116;298.5640964192279;306.2664917522533;310.6737925178565;312.14783640660994;4752.954350042989;5070.391553013644;5172.482751724826;5191.402988656306;5245.659032162912;4078.959210407895;4284.643446104646;5028.321176641152;5094.79620815167;5142.948570514293;3186.601674790651;3832.8118283332255;3943.7633741975574;3954.3475326571083;4004.4994375703036;3476.7392445566556;3669.5596528416627;4000.3199456092534;4012.177503611767;4020;3249.7075263226307;3255.918602034956;3425.640307767686;3482.8258587070673;3777.848886044555;3259.771815972883;3667.7249206309634;3734.1971476132762;3776.7356285060055;3930;3276.5576647152566;3477.4957631143343;3478.286951175003;3496.2832619313235;3503.474478828196;4311.719738217006;4395.4725432947935;5050.464674727706;5092.821751238689;5108.4125325587665;4471.272523760504;4518.43519560055;4535.682502224812;4537.274036154233;4542.432195975503;4958.363739965803;5276.9736151319385;5311.468853114658;5460.314287855682;5473.562115030788;2967;3719.6466335698065;3726.5900750917376;3758.3986562149926;3765.4206868295305;4794.544518270759;5624.887502249932;5686.687232202185;5718.999999999958;5736.311642602873;3138;3211.6467188609236;3363.512290717832;3650.324689932371;3806.4861243731743;3724.683401910868;3798.582155962842;3838.251540949544;3858.5562660293863;3876.8061596920043;4412.5289837691;4469.374287599739;4481.327800829837;4517.028838799673;4535.501094879561;4848.763565290828;5055.570276526537;5545.417731138173;5636;5639.672593170049;1233.4018001269378;1275.5663074554695;1277.6903673734496;1290.1807352331336;1296.6628676544167;826.3017750001239;872.925801306896;881.678187461572;884.4162852517436;886.1271647427279;5005.849824505271;5012.849614511498;5015.3449361710545;5017.8243761468175;5027.798888044437;5199.974000129975;5259.15853463444;5415.783368665209;5437.945620543823;5454.8909021819345;4227;4332.783360831946;4949.232868905326;4988.5260900214425;5017.140230068826;2349.729781075164;2415.6376543518613;2441.987790061038;2451.656768052474;2455.226603619854;4269.274223382033;4388.714733542373;4625.6530760192445;4721.969553092204;4744.935952860447;3799.3214783578064;4203.873883783492;4641.029740965784;4686.789094490756;4854.611631069506;4877.6829506081995;5240.973795131076;5355.86610334737;5862.824115276549;5890.175375447441;5650.463205995424;5660.773569057192;5663.858403539944;5682.77268909239;5695.7436915338085;5356.303680521507;5548.281342142241;5599.216109744558;5622.522085622768;5629.802956896489;4436.733795972252;5648.774049038157;5808.73860676279;5850.297964244318;5892.705364731832;3479;3517.909448071106;3828.1960788234783;3829.942550861795;3833.4058220975794;4758.31004504338;5343.332083489564;5580.218769372373;5700.258966334516;5732.684702341411;3942.5071866016747;5323.547498462519;5324.866878328073;5343.4389389113585;5352.518273355417;4190.727602705936;4785.808567657255;4911.96848661785;5453.809116680897;5511.200875872896;5080.974595127001;5343.519083282523;5373.516383525345;5383.219433182245;5398.028354896156;4128.731632443882;4846.660733748604;5397.730113494388;5397.8380648580605;5493.835184944458;4463.308187230984;5101;5353.357597088218;5353.892922141613;5355.919661205007 21:27:00 INFO - PROCESS | 1648 | |5;yui.html;698.2807708060698;705.3898377903115;726.9745558905436;731.3125661877833;780.1613265739328;14364.712705745878;15251.694966100686;15673.137977411252;16310.102944338058;16357;14466.349014294356;14670.486532971321;14671.853281467182;14701;14788.778168327457;679.8810208213567;701.0220742064816;712.672170801432;837.2632083766277;852.927501162402;849.4563479373176;849.8087930215682;865.6840253307529;867.839449701804;869.8695195720629;865.0225245472607;889.2574700125404;921.1709461484684;923.4597760310227;923.6997975657904;721.678852910455;879.0155026370442;915.8168366326761;916.8808054952847;918.9678361257357;565.7793460550389;667.0694381338055;667.562746401108;667.919849618044;682.2052309059989;14625.414983400651;14637.634059148606;14662.560123196214;14675.48635797742;14675.77986330206;13674.658133546742;13800.792988105186;13885.37515811791;14092;14125.71748565023;11916.582919597773;12221.96113330368;12496.625101246977;12527.812082818766;12869.057464850488;4386.868393948154;4466.531014243523;4560.407147070892;4686.08621318843;4690.273007683814;113680;113915;114011;114478.42760786143;114784.42607786991;10549.261551691461;10810.243282970117;10834.566617335218;11054.944725276322;11287.209895307415;19939;20118.798812011984;21209.89395053015;21230.575388492143;21257.149714011266;7691.153973062958;7835.294823465915;7837.49056311338;7953.443258971816;7973.20267973198;4264.571368591494;4269.167512335065;4401.537838526972;4413.8234470621455;4437.489688685778;3421.0763093964492;3571.982140089283;3574.4459608760685;3575.606683264839;3577.159367548624;663.2174034639075;667.5327270910382;675.6216518749516;677.6848765324148;685.8422562810581;576.5099665284558;619.9194104766351;628.867937733072;641.3805142016446;643.4723526708148;8764.56177191138;8897.288216942628;9029.322800789967;9037.367384283169;9108.975987328711;558.8692048230901;584.3951510186936;613.3651670521078;621.7140115546808;635.7266375458597;4128.38992792811;4310.116426132635;4381.452318460192;4400.471943366816;4451.003071032593;154844.22577887037;155386;155722;158443.20778396033;161779;133881;136092.27815443635;136250;136321;136422.86097125654;106916;115290.27064594037;115379.5386138434;116680.833191667;119925;8277.420580559303;8471.068182499797;8473.66105355779;8611.82776344482;8654.264387526879;52710;63518.04722929067;63719.36280637134;64694.70610587856;66246.33753662402;86448.56775716333;91817.54091229769;92830;94057.58913616164;94761;11133.165012624248;11286.548538058385;11345.829812552984;11880.99011584025;11989.820152697543;11299.943500282447;11538.423078845855;11966.820497692715;12307.44616492278;12561.560345387868;10106.494675266355;11499.942500287445;11642.185047046625;11685.532578697097;11703.824442633537;11299.322040677585;11414.600488982845;11598.594049208237;11650.184487085822;11785.233959792586;11273.849102944418;11383.54465821358;11620.128490363088;11723.944844963995;12146.757064858477;9356.625734970798;9369.390989585656;9589.712308630753;9634.373765705206;10082.798344033225;9296.39573427725;9795.51022448889;9808.117269445784;9810.362326448758;9815.509224538602 21:27:00 INFO - PROCESS | 1648 | __end_tp_report 21:27:00 INFO - PROCESS | 1648 | __start_cc_report 21:27:00 INFO - PROCESS | 1648 | _x_x_mozilla_cycle_collect,1299 21:27:00 INFO - PROCESS | 1648 | __end_cc_report 21:27:00 INFO - PROCESS | 1648 | __startTimestamp1471408020858__endTimestamp 21:27:00 INFO - PROCESS | 1648 | 21:27:00 INFO - PROCESS | 1648 | ------- Summary: start ------- 21:27:00 INFO - PROCESS | 1648 | Number of tests: 6 21:27:00 INFO - PROCESS | 1648 | 21:27:00 INFO - PROCESS | 1648 | [#0] dojo.html Cycles:165 Average:5676.57 Median:5848.59 stddev:667.39 (11.4%) stddev-sans-first:631.05 21:27:00 INFO - PROCESS | 1648 | Values: 2832.9 3159.0 3333.4 3369.8 3378.1 5494.8 5611.9 5613.4 5652.5 5670.9 5638.5 5651.7 5756.3 5766.7 5804.4 5100.7 5135.3 5173.9 5183.4 5260.3 5255.5 5274.8 5279.3 5294.0 5313.5 5043.6 5126.1 5132.6 5166.3 5184.6 5147.7 5172.0 5177.8 5178.7 5179.8 5088.5 5091.5 5108.6 5136.3 5147.1 5548.9 5678.4 5685.2 5695.7 5699.3 6011.3 6079.7 6202.6 6210.4 6212.3 6170.6 6200.4 6256.4 6263.7 6301.0 5794.4 5801.7 5809.9 5810.8 5823.9 6196.0 6231.8 6255.1 6306.7 6313.6 6081.4 6124.0 6134.1 6140.1 6146.8 6215.2 6228.1 6244.1 6245.8 6246.0 6008.1 6054.4 6176.8 6182.9 6212.2 6128.9 6130.7 6135.0 6178.5 6215.3 4847.6 4848.5 4865.2 4870.0 4915.9 4357.5 4372.9 4409.4 4426.7 4459.9 4754.5 5591.6 5641.0 5644.8 5671.1 4939.8 6152.2 6228.8 6303.6 6305.1 5696.0 5729.7 5747.2 5757.9 5762.6 5328.6 5365.1 5369.1 5370.0 5370.5 6233.6 6239.3 6250.9 6269.7 6292.2 6256.2 6261.0 6264.0 6274.6 6283.4 6173.5 6269.2 6297.2 6312.6 6314.1 5985.3 6074.2 6089.0 6089.1 6159.9 6217.2 6223.2 6231.8 6243.9 6266.3 6038.6 6069.7 6070.8 6073.5 6079.3 4835.9 5359.8 5958.8 5997.3 6013.9 4463.6 5825.8 5848.6 5951.6 5955.7 6045.4 6073.2 6078.7 6080.6 6094.5 5714.3 5804.0 5851.5 5853.8 5946.3 21:27:00 INFO - PROCESS | 1648 | 21:27:00 INFO - PROCESS | 1648 | [#1] ext.html Cycles:180 Average:64563.06 Median:3522.05 stddev:135401.11 (3844.4%) stddev-sans-first:135695.45 21:27:00 INFO - PROCESS | 1648 | Values: 475.3 476.1 480.8 533.4 544.4 30406.7 33848.0 39871.4 41211.0 43381.3 40876.0 41362.4 41381.0 41547.4 41674.8 9609.1 9795.1 9814.3 9819.9 9843.2 8690.7 8922.6 11726.8 11994.3 12023.4 11956.9 12019.8 12031.7 12034.7 12056.9 11786.1 11896.5 11898.4 11914.0 11915.5 11629.2 11710.4 11719.9 11812.6 11828.2 39435.6 39726.4 39749.4 39806.8 39869.0 3391.5 3442.9 3464.0 3464.6 3579.5 30158.5 31248.2 31391.7 31446.9 31571.2 3179.4 3207.7 3247.4 3317.2 3317.6 451366.0 455920.0 460081.0 460715.0 466997.7 56246.7 56322.7 56545.6 56592.4 56704.7 49484.3 59730.1 59815.4 59867.8 59887.0 16121.8 16352.3 16354.0 16378.6 16385.0 11483.4 11842.4 12909.7 12951.6 13025.4 14903.5 15332.9 15333.2 15575.9 15776.7 6115.8 6269.5 6524.0 6601.4 6626.2 744.8 948.4 954.9 1025.3 1063.9 27210.7 28036.7 28673.7 28958.2 29003.1 949.2 969.2 1034.4 1073.7 1093.2 13729.9 14947.8 15052.0 15179.6 15313.9 568305.0 572263.3 577215.0 583967.0 585373.0 57986.7 58098.5 58183.4 58377.4 58479.0 1224.1 1342.2 1374.8 1387.4 1403.8 29992.7 30889.4 30892.0 31526.1 31683.7 48145.0 48573.5 48581.5 48636.8 48780.0 476644.0 478224.0 481168.2 485428.0 486592.0 23800.4 24306.4 24338.8 24381.9 24471.0 46319.3 46538.5 46783.8 47217.3 48019.0 34359.0 38507.0 38676.4 38720.0 39759.0 32295.0 38184.2 38330.8 39107.6 39395.0 37865.6 38375.8 38828.6 38921.0 39307.0 31604.8 34308.3 34373.0 34532.6 34543.2 22131.5 23568.0 25354.9 25844.6 25906.0 21:27:00 INFO - PROCESS | 1648 | 21:27:00 INFO - PROCESS | 1648 | [#2] jquery.html Cycles:180 Average:37062.35 Median:18931.20 stddev:99242.26 (524.2%) stddev-sans-first:99482.40 21:27:00 INFO - PROCESS | 1648 | Values: 356.6 374.1 377.6 384.6 408.1 15480.5 15771.4 20475.6 20870.6 20929.1 20829.5 21073.7 21437.7 21559.0 22061.4 5153.7 5905.6 6015.5 6094.4 6141.5 4193.0 5941.7 6077.4 6129.2 6152.0 4400.8 6368.1 6664.7 6720.0 6788.3 6604.2 6683.4 6726.3 6740.2 6741.1 5831.6 5833.9 5836.5 5837.9 5842.1 25635.9 26256.9 26437.7 27160.5 27543.6 2245.1 2272.9 2303.9 2316.5 2474.7 15568.9 15748.7 16025.3 16164.8 16615.3 1623.0 1830.1 1835.6 1875.2 1949.7 105022.0 123372.0 123687.0 123949.0 155826.4 15606.4 20640.7 21203.9 21548.4 21588.6 34715.3 35187.8 35246.8 35305.3 35480.0 9494.7 11169.9 11282.8 11325.7 11553.2 9314.4 9326.4 9344.0 9532.0 9538.0 8100.3 9343.4 9735.3 9862.0 9885.6 3147.1 3593.5 3695.4 3697.8 3831.5 802.8 843.0 878.5 915.0 957.7 16720.8 20495.6 20511.0 21034.8 21148.0 783.6 887.2 892.5 922.9 929.5 10626.8 11190.1 11190.3 11240.9 11418.0 571537.0 586760.0 588396.0 602653.0 604472.0 132024.0 143322.3 145754.0 145903.0 147756.8 984.6 1005.6 1025.7 1028.3 1032.0 19002.1 19412.9 19602.9 19780.0 19836.8 50801.0 57028.7 57882.7 59002.0 59680.7 82185.8 85175.6 86622.0 86700.0 87512.6 7946.1 7972.4 7992.7 8212.9 8463.5 9397.2 12714.4 13034.9 13354.9 13413.3 10995.6 11140.5 11286.8 11297.5 11340.9 6407.7 10916.5 11043.4 11258.8 11325.3 11490.3 11562.6 11615.8 11776.2 11798.9 5845.8 7881.4 7887.8 8160.6 8256.1 8996.6 11121.7 11221.4 11337.9 11636.2 21:27:00 INFO - PROCESS | 1648 | 21:27:00 INFO - PROCESS | 1648 | [#3] mootools.html Cycles:180 Average:5657.76 Median:5040.02 stddev:3166.79 (62.8%) stddev-sans-first:3159.17 21:27:00 INFO - PROCESS | 1648 | Values: 1355.7 1531.9 1562.6 1647.8 1818.0 7480.1 8364.5 8720.6 8722.6 8823.2 8606.9 8714.6 8722.3 8749.3 8774.2 2360.6 2388.2 2391.1 2391.3 2404.7 1993.8 2306.9 2374.0 2375.1 2381.2 2105.6 2250.5 2358.7 2371.1 2375.1 2310.8 2338.7 2342.3 2346.5 2358.3 2340.1 2346.4 2354.9 2364.3 2368.4 7790.8 8583.4 8730.0 8761.5 8772.7 5110.8 5311.3 5312.2 5314.8 5314.9 3588.6 3630.3 3646.1 3694.4 3696.1 976.4 1078.7 1083.7 1091.4 1102.6 11499.6 11540.4 11600.7 11613.3 11683.1 4366.5 4488.1 4605.4 4610.8 4630.2 9183.8 9184.7 9185.0 9198.9 9218.5 5251.2 5252.3 5252.4 5255.6 5258.5 3970.6 4390.5 4401.3 4541.8 4941.3 3740.8 3785.2 3791.5 3836.1 3864.6 1155.9 1165.7 1170.2 1178.6 1181.5 813.5 892.6 923.9 954.7 957.9 5801.0 6094.7 6107.8 6181.7 6409.6 701.0 919.4 928.0 941.5 958.4 3803.8 4020.6 4052.5 4098.3 4130.2 10460.2 10739.5 10850.1 10856.8 10856.9 10806.7 10807.0 10807.9 10821.4 10829.7 7595.4 7992.4 8061.6 8205.3 8206.8 5895.7 6070.0 6094.9 6167.5 6213.1 8358.5 10192.3 10198.2 10198.9 10207.5 9221.1 9874.6 10186.7 10330.6 10407.2 6076.6 7447.8 7559.1 7644.8 7666.6 8223.3 8223.8 8274.2 8310.3 8328.8 7467.1 7469.3 7526.2 7551.0 7579.1 6408.4 7164.5 7209.6 7297.8 7544.1 6977.6 7009.0 7077.6 7092.8 7092.9 4857.4 4883.5 4926.4 5001.5 5014.7 5065.3 5123.4 5190.2 5203.8 5225.3 21:27:00 INFO - PROCESS | 1648 | 21:27:00 INFO - PROCESS | 1648 | [#4] prototype.html Cycles:180 Average:4293.09 Median:4755.63 stddev:1346.36 (28.3%) stddev-sans-first:1316.25 21:27:00 INFO - PROCESS | 1648 | Values: 293.6 298.6 306.3 310.7 312.1 4753.0 5070.4 5172.5 5191.4 5245.7 4079.0 4284.6 5028.3 5094.8 5142.9 3186.6 3832.8 3943.8 3954.3 4004.5 3476.7 3669.6 4000.3 4012.2 4020.0 3249.7 3255.9 3425.6 3482.8 3777.8 3259.8 3667.7 3734.2 3776.7 3930.0 3276.6 3477.5 3478.3 3496.3 3503.5 4311.7 4395.5 5050.5 5092.8 5108.4 4471.3 4518.4 4535.7 4537.3 4542.4 4958.4 5277.0 5311.5 5460.3 5473.6 2967.0 3719.6 3726.6 3758.4 3765.4 4794.5 5624.9 5686.7 5719.0 5736.3 3138.0 3211.6 3363.5 3650.3 3806.5 3724.7 3798.6 3838.3 3858.6 3876.8 4412.5 4469.4 4481.3 4517.0 4535.5 4848.8 5055.6 5545.4 5636.0 5639.7 1233.4 1275.6 1277.7 1290.2 1296.7 826.3 872.9 881.7 884.4 886.1 5005.8 5012.8 5015.3 5017.8 5027.8 5200.0 5259.2 5415.8 5437.9 5454.9 4227.0 4332.8 4949.2 4988.5 5017.1 2349.7 2415.6 2442.0 2451.7 2455.2 4269.3 4388.7 4625.7 4722.0 4744.9 3799.3 4203.9 4641.0 4686.8 4854.6 4877.7 5241.0 5355.9 5862.8 5890.2 5650.5 5660.8 5663.9 5682.8 5695.7 5356.3 5548.3 5599.2 5622.5 5629.8 4436.7 5648.8 5808.7 5850.3 5892.7 3479.0 3517.9 3828.2 3829.9 3833.4 4758.3 5343.3 5580.2 5700.3 5732.7 3942.5 5323.5 5324.9 5343.4 5352.5 4190.7 4785.8 4912.0 5453.8 5511.2 5081.0 5343.5 5373.5 5383.2 5398.0 4128.7 4846.7 5397.7 5397.8 5493.8 4463.3 5101.0 5353.4 5353.9 5355.9 21:27:00 INFO - PROCESS | 1648 | 21:27:00 INFO - PROCESS | 1648 | [#5] yui.html Cycles:180 Average:25143.20 Median:4384.16 stddev:41526.14 (947.2%) stddev-sans-first:41602.07 21:27:00 INFO - PROCESS | 1648 | Values: 698.3 705.4 727.0 731.3 780.2 14364.7 15251.7 15673.1 16310.1 16357.0 14466.3 14670.5 14671.9 14701.0 14788.8 679.9 701.0 712.7 837.3 852.9 849.5 849.8 865.7 867.8 869.9 865.0 889.3 921.2 923.5 923.7 721.7 879.0 915.8 916.9 919.0 565.8 667.1 667.6 667.9 682.2 14625.4 14637.6 14662.6 14675.5 14675.8 13674.7 13800.8 13885.4 14092.0 14125.7 11916.6 12222.0 12496.6 12527.8 12869.1 4386.9 4466.5 4560.4 4686.1 4690.3 113680.0 113915.0 114011.0 114478.4 114784.4 10549.3 10810.2 10834.6 11054.9 11287.2 19939.0 20118.8 21209.9 21230.6 21257.1 7691.2 7835.3 7837.5 7953.4 7973.2 4264.6 4269.2 4401.5 4413.8 4437.5 3421.1 3572.0 3574.4 3575.6 3577.2 663.2 667.5 675.6 677.7 685.8 576.5 619.9 628.9 641.4 643.5 8764.6 8897.3 9029.3 9037.4 9109.0 558.9 584.4 613.4 621.7 635.7 4128.4 4310.1 4381.5 4400.5 4451.0 154844.2 155386.0 155722.0 158443.2 161779.0 133881.0 136092.3 136250.0 136321.0 136422.9 106916.0 115290.3 115379.5 116680.8 119925.0 8277.4 8471.1 8473.7 8611.8 8654.3 52710.0 63518.0 63719.4 64694.7 66246.3 86448.6 91817.5 92830.0 94057.6 94761.0 11133.2 11286.5 11345.8 11881.0 11989.8 11299.9 11538.4 11966.8 12307.4 12561.6 10106.5 11499.9 11642.2 11685.5 11703.8 11299.3 11414.6 11598.6 11650.2 11785.2 11273.8 11383.5 11620.1 11723.9 12146.8 9356.6 9369.4 9589.7 9634.4 10082.8 9296.4 9795.5 9808.1 9810.4 9815.5 21:27:00 INFO - PROCESS | 1648 | -------- Summary: end -------- 21:27:00 INFO - PROCESS | 1648 | 21:27:01 INFO - TEST-INFO | 1648: exit 0 21:27:01 INFO - TEST-OK | dromaeo_css | took 1117918ms 21:27:01 INFO - TEST-START | kraken 21:27:01 INFO - operating with platform_type : mac_ 21:27:01 INFO - Initialising browser for kraken test... 21:27:01 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/tmpTHwpiE/profile http://localhost:49274/getInfo.html) 21:27:03 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 21:27:03 INFO - PROCESS | 1653 | colorDepth:24 21:27:03 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 21:27:03 INFO - PROCESS | 1653 | __metrics 21:27:03 INFO - PROCESS | 1653 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:27:03 INFO - PROCESS | 1653 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:27:04 INFO - TEST-INFO | 1653: exit 0 21:27:04 INFO - Browser initialized. 21:27:04 INFO - Running cycle 1/1 for kraken test... 21:27:04 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/tmpTHwpiE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:27:16 INFO - PROCESS | 1654 | RSS: Main: 227913728 21:27:16 INFO - PROCESS | 1654 | 21:27:19 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 21:27:20 INFO - PROCESS | 1654 | RSS: Main: 285298688 21:27:20 INFO - PROCESS | 1654 | 21:27:22 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 21:27:23 INFO - PROCESS | 1654 | RSS: Main: 295284736 21:27:23 INFO - PROCESS | 1654 | 21:27:27 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 21:27:27 INFO - PROCESS | 1654 | RSS: Main: 386527232 21:27:27 INFO - PROCESS | 1654 | 21:27:30 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 21:27:30 INFO - PROCESS | 1654 | RSS: Main: 289427456 21:27:30 INFO - PROCESS | 1654 | 21:27:32 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:27:33 INFO - PROCESS | 1654 | RSS: Main: 293400576 21:27:33 INFO - PROCESS | 1654 | 21:27:36 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 21:27:36 INFO - PROCESS | 1654 | RSS: Main: 332255232 21:27:36 INFO - PROCESS | 1654 | 21:27:39 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 21:27:40 INFO - PROCESS | 1654 | RSS: Main: 333635584 21:27:40 INFO - PROCESS | 1654 | 21:27:43 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 21:27:43 INFO - PROCESS | 1654 | RSS: Main: 331456512 21:27:43 INFO - PROCESS | 1654 | 21:27:45 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:27:46 INFO - PROCESS | 1654 | RSS: Main: 300990464 21:27:46 INFO - PROCESS | 1654 | 21:27:47 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:27:48 INFO - PROCESS | 1654 | RSS: Main: 307671040 21:27:48 INFO - PROCESS | 1654 | 21:27:50 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:27:51 INFO - PROCESS | 1654 | RSS: Main: 302223360 21:27:51 INFO - PROCESS | 1654 | 21:27:54 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:27:54 INFO - PROCESS | 1654 | RSS: Main: 312778752 21:27:54 INFO - PROCESS | 1654 | 21:27:57 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:27:58 INFO - PROCESS | 1654 | RSS: Main: 314236928 21:27:58 INFO - PROCESS | 1654 | 21:28:00 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 21:28:00 INFO - PROCESS | 1654 | RSS: Main: 357752832 21:28:00 INFO - PROCESS | 1654 | 21:28:00 INFO - PROCESS | 1654 | __start_tp_report 21:28:00 INFO - PROCESS | 1654 | _x_x_mozilla_page_load 21:28:00 INFO - PROCESS | 1654 | _x_x_mozilla_page_load_details 21:28:00 INFO - PROCESS | 1654 | |i|pagename|runs| 21:28:00 INFO - PROCESS | 1654 | |0;ai-astar;103;112;113;113;108;113;112;114;113;114 21:28:00 INFO - PROCESS | 1654 | |1;audio-beat-detection;142;114;107;165;107;107;128;106;142;107 21:28:00 INFO - PROCESS | 1654 | |2;audio-dft;181;214;260;185;174;259;224;184;183;182 21:28:00 INFO - PROCESS | 1654 | |3;audio-fft;75;60;79;77;62;75;83;78;116;80 21:28:00 INFO - PROCESS | 1654 | |4;audio-oscillator;86;97;125;99;99;69;95;71;67;102 21:28:00 INFO - PROCESS | 1654 | |5;imaging-gaussian-blur;87;85;91;130;87;84;88;85;87;86 21:28:00 INFO - PROCESS | 1654 | |6;imaging-darkroom;93;93;97;94;94;93;95;97;93;93 21:28:00 INFO - PROCESS | 1654 | |7;imaging-desaturate;86;84;85;85;85;84;83;85;86;85 21:28:00 INFO - PROCESS | 1654 | |8;json-parse-financial;58;56;56;58;54;56;56;54;56;55 21:28:00 INFO - PROCESS | 1654 | |9;json-stringify-tinderbox;63;69;70;78;72;68;68;70;68;69 21:28:00 INFO - PROCESS | 1654 | |10;stanford-crypto-aes;88;86;85;84;86;83;81;84;86;88 21:28:00 INFO - PROCESS | 1654 | |11;stanford-crypto-ccm;140;140;139;143;145;145;133;140;154;141 21:28:00 INFO - PROCESS | 1654 | |12;stanford-crypto-pbkdf2;171;171;168;173;170;169;169;170;172;171 21:28:00 INFO - PROCESS | 1654 | |13;stanford-crypto-sha256-iterative;69;67;68;68;68;69;69;68;68;68 21:28:00 INFO - PROCESS | 1654 | __end_tp_report 21:28:00 INFO - PROCESS | 1654 | __start_cc_report 21:28:00 INFO - PROCESS | 1654 | _x_x_mozilla_cycle_collect,2032 21:28:00 INFO - PROCESS | 1654 | __end_cc_report 21:28:00 INFO - PROCESS | 1654 | __startTimestamp1471408080349__endTimestamp 21:28:00 INFO - PROCESS | 1654 | 21:28:00 INFO - PROCESS | 1654 | ------- Summary: start ------- 21:28:00 INFO - PROCESS | 1654 | Number of tests: 14 21:28:00 INFO - PROCESS | 1654 | 21:28:00 INFO - PROCESS | 1654 | [#0] ai-astar Cycles:10 Average:111.50 Median:113.00 stddev:3.44 (3.0%) stddev-sans-first:1.81 21:28:00 INFO - PROCESS | 1654 | Values: 103.0 112.0 113.0 113.0 108.0 113.0 112.0 114.0 113.0 114.0 21:28:00 INFO - PROCESS | 1654 | 21:28:00 INFO - PROCESS | 1654 | [#1] audio-beat-detection Cycles:10 Average:122.50 Median:121.00 stddev:20.82 (17.2%) stddev-sans-first:20.86 21:28:00 INFO - PROCESS | 1654 | Values: 142.0 114.0 107.0 165.0 107.0 107.0 128.0 106.0 142.0 107.0 21:28:00 INFO - PROCESS | 1654 | 21:28:00 INFO - PROCESS | 1654 | [#2] audio-dft Cycles:10 Average:204.60 Median:199.50 stddev:32.95 (16.5%) stddev-sans-first:33.83 21:28:00 INFO - PROCESS | 1654 | Values: 181.0 214.0 260.0 185.0 174.0 259.0 224.0 184.0 183.0 182.0 21:28:00 INFO - PROCESS | 1654 | 21:28:00 INFO - PROCESS | 1654 | [#3] audio-fft Cycles:10 Average:78.50 Median:77.50 stddev:15.17 (19.6%) stddev-sans-first:16.03 21:28:00 INFO - PROCESS | 1654 | Values: 75.0 60.0 79.0 77.0 62.0 75.0 83.0 78.0 116.0 80.0 21:28:00 INFO - PROCESS | 1654 | 21:28:00 INFO - PROCESS | 1654 | [#4] audio-oscillator Cycles:10 Average:91.00 Median:90.50 stddev:18.08 (20.0%) stddev-sans-first:19.09 21:28:00 INFO - PROCESS | 1654 | Values: 86.0 97.0 125.0 99.0 99.0 69.0 95.0 71.0 67.0 102.0 21:28:00 INFO - PROCESS | 1654 | 21:28:00 INFO - PROCESS | 1654 | [#5] imaging-gaussian-blur Cycles:10 Average:91.00 Median:87.00 stddev:13.84 (15.9%) stddev-sans-first:14.60 21:28:00 INFO - PROCESS | 1654 | Values: 87.0 85.0 91.0 130.0 87.0 84.0 88.0 85.0 87.0 86.0 21:28:00 INFO - PROCESS | 1654 | 21:28:00 INFO - PROCESS | 1654 | [#6] imaging-darkroom Cycles:10 Average:94.20 Median:94.00 stddev:1.62 (1.7%) stddev-sans-first:1.66 21:28:00 INFO - PROCESS | 1654 | Values: 93.0 93.0 97.0 94.0 94.0 93.0 95.0 97.0 93.0 93.0 21:28:00 INFO - PROCESS | 1654 | 21:28:00 INFO - PROCESS | 1654 | [#7] imaging-desaturate Cycles:10 Average:84.80 Median:85.00 stddev:0.92 (1.1%) stddev-sans-first:0.87 21:28:00 INFO - PROCESS | 1654 | Values: 86.0 84.0 85.0 85.0 85.0 84.0 83.0 85.0 86.0 85.0 21:28:00 INFO - PROCESS | 1654 | 21:28:00 INFO - PROCESS | 1654 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:56.00 stddev:1.37 (2.4%) stddev-sans-first:1.22 21:28:00 INFO - PROCESS | 1654 | Values: 58.0 56.0 56.0 58.0 54.0 56.0 56.0 54.0 56.0 55.0 21:28:00 INFO - PROCESS | 1654 | 21:28:00 INFO - PROCESS | 1654 | [#9] json-stringify-tinderbox Cycles:10 Average:69.50 Median:69.50 stddev:3.78 (5.4%) stddev-sans-first:3.19 21:28:00 INFO - PROCESS | 1654 | Values: 63.0 69.0 70.0 78.0 72.0 68.0 68.0 70.0 68.0 69.0 21:28:00 INFO - PROCESS | 1654 | 21:28:00 INFO - PROCESS | 1654 | [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:86.00 stddev:2.18 (2.5%) stddev-sans-first:2.05 21:28:00 INFO - PROCESS | 1654 | Values: 88.0 86.0 85.0 84.0 86.0 83.0 81.0 84.0 86.0 88.0 21:28:00 INFO - PROCESS | 1654 | 21:28:00 INFO - PROCESS | 1654 | [#11] stanford-crypto-ccm Cycles:10 Average:142.00 Median:142.00 stddev:5.44 (3.8%) stddev-sans-first:5.72 21:28:00 INFO - PROCESS | 1654 | Values: 140.0 140.0 139.0 143.0 145.0 145.0 133.0 140.0 154.0 141.0 21:28:00 INFO - PROCESS | 1654 | 21:28:00 INFO - PROCESS | 1654 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.40 Median:171.00 stddev:1.51 (0.9%) stddev-sans-first:1.58 21:28:00 INFO - PROCESS | 1654 | Values: 171.0 171.0 168.0 173.0 170.0 169.0 169.0 170.0 172.0 171.0 21:28:00 INFO - PROCESS | 1654 | 21:28:00 INFO - PROCESS | 1654 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.00 stddev:0.63 (0.9%) stddev-sans-first:0.60 21:28:00 INFO - PROCESS | 1654 | Values: 69.0 67.0 68.0 68.0 68.0 69.0 69.0 68.0 68.0 68.0 21:28:00 INFO - PROCESS | 1654 | -------- Summary: end -------- 21:28:00 INFO - PROCESS | 1654 | 21:28:01 INFO - TEST-INFO | 1654: exit 0 21:28:01 INFO - TEST-OK | kraken | took 59742ms 21:28:01 INFO - SUITE-END | took 1177s 21:28:01 INFO - Completed test suite (00:19:37) 21:28:01 INFO - javascript benchmark 21:28:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2832.886684532619, 3158.968410315897, 3333.4166520858844, 3369.8315084245787, 3378.0879162626075, 5494.780208791643, 5611.915821262679, 5613.354464236614, 5652.5195358394585, 5670.8582285442835, 5638.548916086703, 5651.717414129298, 5756.251687280658, 5766.740496677649, 5804.361520232771, 5100.69395836251, 5135.306733590974, 5173.870653233662, 5183.429822719498, 5260.316158899338, 5255.500727430888, 5274.841754747364, 5279.2872962150195, 5294.047071527124, 5313.548348390372, 5043.5965122790085, 5126.128558145124, 5132.615053870937, 5166.328377310963, 5184.637075404742, 5147.665401748912, 5171.974140129275, 5177.844664660066, 5178.689278643294, 5179.8446046618665, 5088.542031217171, 5091.516305950966, 5108.616853735947, 5136.280920671109, 5147.0992576298995, 5548.889022219533, 5678.375378708339, 5685.204071430003, 5695.743691533849, 5699.287589051369, 6011.30869949957, 6079.6960151992225, 6202.565820392574, 6210.441060304549, 6212.285587157489, 6170.629762214281, 6200.379962003809, 6256.436920677115, 6263.71813268404, 6301.0, 5794.391588883191, 5801.680907550083, 5809.9419005809405, 5810.82567522975, 5823.912641310384, 6195.96902015487, 6231.844203894939, 6255.093011513305, 6306.747730090745, 6313.621182729051, 6081.422264884829, 6123.964183031302, 6134.141220229171, 6140.105498721277, 6146.784862529879, 6215.192025036717, 6228.128062071313, 6244.12582238487, 6245.781397651061, 6246.0, 6008.098785182257, 6054.424829641177, 6176.826402983419, 6182.876342473215, 6212.192414986113, 6128.877422451526, 6130.707930599209, 6134.987697083657, 6178.474829639441, 6215.285242197115, 4847.636427267969, 4848.490908454632, 4865.197242454955, 4869.952960113593, 4915.877103072452, 4357.4988876279, 4372.934405983913, 4409.426774519292, 4426.712263702849, 4459.888502787457, 4754.548317909793, 5591.6365436246515, 5641.041023026095, 5644.8306550803545, 5671.120976248688, 4939.753012349368, 6152.169457123231, 6228.844278892973, 6303.558750887394, 6305.085762564494, 5695.971520142372, 5729.684867332337, 5747.195392645033, 5757.884842303214, 5762.596618236767, 5328.573714102862, 5365.061114304981, 5369.140937449989, 5369.973150134302, 5370.543503802142, 6233.594816336924, 6239.313675495692, 6250.9062364064575, 6269.749210031548, 6292.182016337847, 6256.155419018374, 6261.0, 6263.96868015657, 6274.560780745304, 6283.37166283368, 6173.536984726074, 6269.185005949197, 6297.181366422519, 6312.5581209314905, 6314.147590075465, 5985.281766188085, 6074.210352654127, 6089.0, 6089.056196289582, 6159.922013647683, 6217.160683307696, 6223.159873417031, 6231.7818876340925, 6243.937560624518, 6266.342034086355, 6038.607490513278, 6069.696515174312, 6070.817875463743, 6073.48375388097, 6079.3312735598165, 4835.854924352275, 5359.820839415323, 5958.76164953397, 5997.31030931431, 6013.909791353046, 4463.598276155161, 5825.76696932118, 5848.590598658053, 5951.613145145551, 5955.731992060281, 6045.365236650088, 6073.180120683828, 6078.72645730952, 6080.604760690541, 6094.54290928191, 5714.342850572071, 5804.042333015174, 5851.502622277154, 5853.824385268449, 5946.316173640087], "value": 5632.8962269261965, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [475.2609691929049, 476.0787875460982, 480.79085597764976, 533.3839415475128, 544.3875639905107, 30406.695933040664, 33847.98456046316, 39871.40192897109, 41211.0, 43381.34927976075, 40876.0, 41362.37956430649, 41381.0, 41547.376789348185, 41674.79162604183, 9609.135177833994, 9795.06946840049, 9814.312998090136, 9819.852702209473, 9843.212542996578, 8690.695825646104, 8922.553872306391, 11726.8240976385, 11994.280343179393, 12023.398830058506, 11956.880431195706, 12019.7596048079, 12031.699207519794, 12034.69913252167, 12056.879431205707, 11786.116041296895, 11896.464659090361, 11898.405079745979, 11914.046876249879, 11915.523379064827, 11629.185956983014, 11710.414479276087, 11719.882801171965, 11812.586559470463, 11828.172027958046, 39435.60564394348, 39726.40410393846, 39749.40375894364, 39806.80096599498, 39869.00327491807, 3391.491276308549, 3442.9483557746653, 3463.9826800866085, 3464.566929133858, 3579.534660494119, 30158.547621785692, 31248.21879453009, 31391.686083139106, 31446.899358522343, 31571.21071973196, 3179.4118088153537, 3207.695268949446, 3247.382997230519, 3317.170707323169, 3317.5853018372704, 451366.0, 455920.0, 460081.0, 460715.0, 466997.66501167614, 56246.71876640591, 56322.7183864078, 56545.628165324226, 56592.43407565954, 56704.71647641818, 49484.257736133986, 59730.10404843931, 59815.401845981854, 59867.802643946874, 59887.0, 16121.838781612034, 16352.264148113363, 16354.018758874505, 16378.590535236714, 16385.0, 11483.368414737102, 11842.407879605986, 12909.677258068623, 12951.611451656465, 13025.413856376295, 14903.478378256708, 15332.923335383251, 15333.156676382907, 15575.922120389325, 15776.68446631061, 6115.755369785159, 6269.498440124779, 6523.988781738838, 6601.3728695773825, 6626.204855417284, 744.8435828475972, 948.393028461785, 954.8854137503405, 1025.3181634213165, 1063.9202059845543, 27210.727892721214, 28036.71963280341, 28673.71326286752, 28958.175511343095, 29003.12990610285, 949.2263804998904, 969.2439896880445, 1034.4000479721744, 1073.6939972108069, 1093.1855767453299, 13729.862701373058, 14947.775783363259, 15052.021618594756, 15179.628602688774, 15313.923430382776, 568305.0, 572263.277367221, 577215.0, 583967.0, 585373.0, 57986.71006645024, 58098.54753631108, 58183.41816581865, 58377.416225838046, 58479.0, 1224.1002862895764, 1342.201390172826, 1374.8075269462283, 1387.3964825301027, 1403.7683782176234, 29992.700072998992, 30889.382212356075, 30892.0, 31526.054218373487, 31683.683163168072, 48145.0, 48573.51426485831, 48581.514184859116, 48636.75681621569, 48780.0, 476644.0, 478224.0, 481168.18831811234, 485428.0, 486592.0, 23800.40498987539, 24306.392340191636, 24338.756612433648, 24381.878090610142, 24471.0, 46319.3052104212, 46538.53461465342, 46783.76608116938, 47217.29174062323, 48019.0, 34358.969230922114, 38507.0, 38676.41985370278, 38720.0, 39759.0, 32295.0, 38184.236315274095, 38330.80834595809, 39107.6089239104, 39395.0, 37865.62134378621, 38375.80812096033, 38828.6117138825, 38921.0, 39307.01732456712, 31604.841975789976, 34308.31383372368, 34373.0, 34532.6474396469, 34543.163957046534, 22131.4507984446, 23568.0, 25354.873225633753, 25844.612330815427, 25906.04161042933], "value": 19708.14128981043, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.64335664335664, 374.1152175105874, 377.5865427357044, 384.5961740172818, 408.0614586451163, 15480.535583932471, 15771.369145234192, 20475.590488190246, 20870.58258834826, 20929.05819238134, 20829.47926301843, 21073.683894741593, 21437.67843482349, 21559.0, 22061.448463788372, 5153.665011774241, 5905.557083218765, 6015.488683461911, 6094.421030002165, 6141.508679305667, 4192.958070419288, 5941.673207973559, 6077.39226077391, 6129.233845769279, 6152.0, 4400.7579583122915, 6368.10846481493, 6664.733410663568, 6720.0, 6788.321167883197, 6604.174478190226, 6683.431908287801, 6726.327367263283, 6740.191177058784, 6741.056252124682, 5831.562632802515, 5833.941660583425, 5836.503897168745, 5837.854053648693, 5842.123681447774, 25635.871820640776, 26256.868715656492, 26437.73562264391, 27160.45679086427, 27543.586846197322, 2245.113180293791, 2272.863628182314, 2303.884805759705, 2316.455632926261, 2474.7277799442045, 15568.922155389264, 15748.685026299525, 16025.278862451218, 16164.838351616569, 16615.252313645917, 1622.9937438787908, 1830.1489807239564, 1835.5502901789014, 1875.22178296007, 1949.727038214651, 105022.0, 123372.0, 123687.0, 123949.0, 155826.40517124953, 15606.375744970073, 20640.69038964417, 21203.879612038672, 21548.35354939354, 21588.56822863534, 34715.30569388598, 35187.82406087953, 35246.766363177165, 35305.293894121976, 35480.0, 9494.667686631074, 11169.888301116885, 11282.830757538644, 11325.71685707864, 11553.191276610725, 9314.394564353295, 9326.393784403992, 9343.953280233556, 9532.0, 9538.0, 8100.270975612223, 9343.392679475812, 9735.318527702993, 9862.0, 9885.604575816888, 3147.0960069158286, 3593.4789455528803, 3695.3902606070237, 3697.759645623026, 3831.5402151741414, 802.7631848604676, 843.0305149078487, 878.4509681449094, 914.9542522873829, 957.7318350861769, 16720.832791672172, 20495.590088198154, 20511.0, 21034.78965210359, 21148.0, 783.6356094416124, 887.2369762004671, 892.4779004282437, 922.8846394200725, 929.5398777604994, 10626.787464250672, 11190.104791616652, 11190.32858028521, 11240.943795280971, 11418.02946749519, 571537.0, 586760.0, 588396.0, 602653.0, 604472.0, 132024.0, 143322.28338858238, 145754.0, 145903.0, 147756.7916170891, 984.5618699678574, 1005.5877090392904, 1025.733309339562, 1028.3058935218548, 1031.9845202321972, 19002.1449034791, 19412.902935485232, 19602.90198548998, 19780.01099944968, 19836.801631983497, 50800.96796128114, 57028.71485642711, 57882.710586446796, 59002.0, 59680.70159649174, 82185.76721349065, 85175.574122129, 86622.0, 86700.0, 87512.5624371874, 7946.125926148235, 7972.441929064909, 7992.680292788224, 8212.876806847782, 8463.49219046859, 9397.154256116983, 12714.364281785689, 13034.869651303365, 13354.866451335361, 13413.32933353348, 10995.615153469591, 11140.498677559368, 11286.774264514499, 11297.491612877604, 11340.886591133984, 6407.71165297572, 10916.454177291262, 11043.39261340634, 11258.83111753308, 11325.263857849213, 11490.316897027224, 11562.595309164139, 11615.76768464643, 11776.234544754563, 11798.941005294919, 5845.795397161079, 7881.448298619041, 7887.84224315522, 8160.632771525177, 8256.091829898827, 8996.595153218252, 11121.721956951142, 11221.438928053401, 11337.886621134014, 11636.243644163102], "value": 10684.081463452183, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1355.6610847288177, 1531.9387224511017, 1562.6405926636871, 1647.8187399386065, 1817.9545511362205, 7480.13978392485, 8364.456310339823, 8720.5639718014, 8722.563871806417, 8823.16179962904, 8606.87089693655, 8714.564271786401, 8722.302215822734, 8749.343799215068, 8774.210321071103, 2360.551495215908, 2388.199953015742, 2391.0555330644384, 2391.2587097999676, 2404.651325557793, 1993.8236440500102, 2306.8615883046987, 2374.03851440167, 2375.0974629640714, 2381.249906279525, 2105.6420408530585, 2250.4711392822674, 2358.7287461941924, 2371.087131454394, 2375.1449478187837, 2310.780475854791, 2338.684277622525, 2342.332435255944, 2346.495503466746, 2358.25714899806, 2340.0873659272897, 2346.366481050124, 2354.9175778847657, 2364.3261670423844, 2368.39605900496, 7790.805229869242, 8583.399162058658, 8729.956350218208, 8761.51811650359, 8772.73681789541, 5110.770015349318, 5311.256424100629, 5312.150055991062, 5314.7608357624, 5314.946850531523, 3588.5873124590744, 3630.2739452109417, 3646.0702520857276, 3694.3534881395917, 3696.075981004749, 976.4190306767462, 1078.7141407527013, 1083.6748975307376, 1091.3615534912085, 1102.597551893561, 11499.59751408705, 11540.365279909602, 11600.709982250426, 11613.30320180792, 11683.12376571752, 4366.454193225847, 4488.1248156609145, 4605.447346318463, 4610.76946152691, 4630.189716799547, 9183.816323673489, 9184.724458266262, 9184.954075229582, 9198.862017069749, 9218.53907304632, 5251.238570407269, 5252.29094072303, 5252.395974462986, 5255.605829562798, 5258.501327121752, 3970.6029397060065, 4390.538993405647, 4401.2517871961845, 4541.84103556374, 4941.258811178352, 3740.831662575191, 3785.242951409729, 3791.5071040764524, 3836.1368692044066, 3864.555576108727, 1155.8959693627614, 1165.6619580321612, 1170.2042611024415, 1178.5816035307514, 1181.474243961429, 813.4875028731861, 892.6250974590688, 923.8891333039944, 954.6897258391051, 957.8888489352457, 5800.970995144998, 6094.695265236809, 6107.84730381744, 6181.690915454209, 6409.583377080475, 700.9719611215494, 919.434547753127, 928.0441145620022, 941.5104145844259, 958.3674774648698, 3803.82882770276, 4020.6073430964666, 4052.513698356216, 4098.323776576832, 4130.235906357333, 10460.215483838743, 10739.463026848627, 10850.077743391743, 10856.78286434267, 10856.945715271373, 10806.675799726021, 10807.027367536959, 10807.891921080689, 10821.350718956888, 10829.67510974672, 7595.430342724318, 7992.400569957276, 8061.596920154087, 8205.261526462647, 8206.753797386087, 5895.659903420269, 6070.028795392716, 6094.939050609437, 6167.488965203554, 6213.099100630474, 8358.5402802844, 10192.286539942133, 10198.184145268213, 10198.898011019795, 10207.489625518843, 9221.077892210993, 9874.605015799287, 10186.745331366776, 10330.586776529155, 10407.21945854079, 6076.605020673642, 7447.81380465471, 7559.092908850753, 7644.808879777827, 7666.616669166631, 8223.342132629496, 8223.79440513968, 8274.172582741678, 8310.252077313071, 8328.833423331378, 7467.141278753013, 7469.290417410337, 7526.209747976383, 7550.962245188739, 7579.090509138939, 6408.391202835724, 7164.462665300019, 7209.6034718091005, 7297.781066568012, 7544.094708634999, 6977.616231107338, 7009.018737376873, 7077.6461176941975, 7092.787216383516, 7092.858142837217, 4857.417109946829, 4883.462819089827, 4926.3842019747535, 5001.524855138756, 5014.72419016943, 5065.316182315488, 5123.38519377677, 5190.169572868323, 5203.840406231371, 5225.294585230945], "value": 4541.155601484156, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.5948391220116, 298.5640964192279, 306.2664917522533, 310.6737925178565, 312.14783640660994, 4752.954350042989, 5070.391553013644, 5172.482751724826, 5191.402988656306, 5245.659032162912, 4078.959210407895, 4284.643446104646, 5028.321176641152, 5094.79620815167, 5142.948570514293, 3186.601674790651, 3832.8118283332255, 3943.7633741975574, 3954.3475326571083, 4004.4994375703036, 3476.7392445566556, 3669.5596528416627, 4000.3199456092534, 4012.177503611767, 4020.0, 3249.7075263226307, 3255.918602034956, 3425.640307767686, 3482.8258587070673, 3777.848886044555, 3259.771815972883, 3667.7249206309634, 3734.1971476132762, 3776.7356285060055, 3930.0, 3276.5576647152566, 3477.4957631143343, 3478.286951175003, 3496.2832619313235, 3503.474478828196, 4311.719738217006, 4395.4725432947935, 5050.464674727706, 5092.821751238689, 5108.4125325587665, 4471.272523760504, 4518.43519560055, 4535.682502224812, 4537.274036154233, 4542.432195975503, 4958.363739965803, 5276.9736151319385, 5311.468853114658, 5460.314287855682, 5473.562115030788, 2967.0, 3719.6466335698065, 3726.5900750917376, 3758.3986562149926, 3765.4206868295305, 4794.544518270759, 5624.887502249932, 5686.687232202185, 5718.999999999958, 5736.311642602873, 3138.0, 3211.6467188609236, 3363.512290717832, 3650.324689932371, 3806.4861243731743, 3724.683401910868, 3798.582155962842, 3838.251540949544, 3858.5562660293863, 3876.8061596920043, 4412.5289837691, 4469.374287599739, 4481.327800829837, 4517.028838799673, 4535.501094879561, 4848.763565290828, 5055.570276526537, 5545.417731138173, 5636.0, 5639.672593170049, 1233.4018001269378, 1275.5663074554695, 1277.6903673734496, 1290.1807352331336, 1296.6628676544167, 826.3017750001239, 872.925801306896, 881.678187461572, 884.4162852517436, 886.1271647427279, 5005.849824505271, 5012.849614511498, 5015.3449361710545, 5017.8243761468175, 5027.798888044437, 5199.974000129975, 5259.15853463444, 5415.783368665209, 5437.945620543823, 5454.8909021819345, 4227.0, 4332.783360831946, 4949.232868905326, 4988.5260900214425, 5017.140230068826, 2349.729781075164, 2415.6376543518613, 2441.987790061038, 2451.656768052474, 2455.226603619854, 4269.274223382033, 4388.714733542373, 4625.6530760192445, 4721.969553092204, 4744.935952860447, 3799.3214783578064, 4203.873883783492, 4641.029740965784, 4686.789094490756, 4854.611631069506, 4877.6829506081995, 5240.973795131076, 5355.86610334737, 5862.824115276549, 5890.175375447441, 5650.463205995424, 5660.773569057192, 5663.858403539944, 5682.77268909239, 5695.7436915338085, 5356.303680521507, 5548.281342142241, 5599.216109744558, 5622.522085622768, 5629.802956896489, 4436.733795972252, 5648.774049038157, 5808.73860676279, 5850.297964244318, 5892.705364731832, 3479.0, 3517.909448071106, 3828.1960788234783, 3829.942550861795, 3833.4058220975794, 4758.31004504338, 5343.332083489564, 5580.218769372373, 5700.258966334516, 5732.684702341411, 3942.5071866016747, 5323.547498462519, 5324.866878328073, 5343.4389389113585, 5352.518273355417, 4190.727602705936, 4785.808567657255, 4911.96848661785, 5453.809116680897, 5511.200875872896, 5080.974595127001, 5343.519083282523, 5373.516383525345, 5383.219433182245, 5398.028354896156, 4128.731632443882, 4846.660733748604, 5397.730113494388, 5397.8380648580605, 5493.835184944458, 4463.308187230984, 5101.0, 5353.357597088218, 5353.892922141613, 5355.919661205007], "value": 3873.877482256872, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [698.2807708060698, 705.3898377903115, 726.9745558905436, 731.3125661877833, 780.1613265739328, 14364.712705745878, 15251.694966100686, 15673.137977411252, 16310.102944338058, 16357.0, 14466.349014294356, 14670.486532971321, 14671.853281467182, 14701.0, 14788.778168327457, 679.8810208213567, 701.0220742064816, 712.672170801432, 837.2632083766277, 852.927501162402, 849.4563479373176, 849.8087930215682, 865.6840253307529, 867.839449701804, 869.8695195720629, 865.0225245472607, 889.2574700125404, 921.1709461484684, 923.4597760310227, 923.6997975657904, 721.678852910455, 879.0155026370442, 915.8168366326761, 916.8808054952847, 918.9678361257357, 565.7793460550389, 667.0694381338055, 667.562746401108, 667.919849618044, 682.2052309059989, 14625.414983400651, 14637.634059148606, 14662.560123196214, 14675.48635797742, 14675.77986330206, 13674.658133546742, 13800.792988105186, 13885.37515811791, 14092.0, 14125.71748565023, 11916.582919597773, 12221.96113330368, 12496.625101246977, 12527.812082818766, 12869.057464850488, 4386.868393948154, 4466.531014243523, 4560.407147070892, 4686.08621318843, 4690.273007683814, 113680.0, 113915.0, 114011.0, 114478.42760786143, 114784.42607786991, 10549.261551691461, 10810.243282970117, 10834.566617335218, 11054.944725276322, 11287.209895307415, 19939.0, 20118.798812011984, 21209.89395053015, 21230.575388492143, 21257.149714011266, 7691.153973062958, 7835.294823465915, 7837.49056311338, 7953.443258971816, 7973.20267973198, 4264.571368591494, 4269.167512335065, 4401.537838526972, 4413.8234470621455, 4437.489688685778, 3421.0763093964492, 3571.982140089283, 3574.4459608760685, 3575.606683264839, 3577.159367548624, 663.2174034639075, 667.5327270910382, 675.6216518749516, 677.6848765324148, 685.8422562810581, 576.5099665284558, 619.9194104766351, 628.867937733072, 641.3805142016446, 643.4723526708148, 8764.56177191138, 8897.288216942628, 9029.322800789967, 9037.367384283169, 9108.975987328711, 558.8692048230901, 584.3951510186936, 613.3651670521078, 621.7140115546808, 635.7266375458597, 4128.38992792811, 4310.116426132635, 4381.452318460192, 4400.471943366816, 4451.003071032593, 154844.22577887037, 155386.0, 155722.0, 158443.20778396033, 161779.0, 133881.0, 136092.27815443635, 136250.0, 136321.0, 136422.86097125654, 106916.0, 115290.27064594037, 115379.5386138434, 116680.833191667, 119925.0, 8277.420580559303, 8471.068182499797, 8473.66105355779, 8611.82776344482, 8654.264387526879, 52710.0, 63518.04722929067, 63719.36280637134, 64694.70610587856, 66246.33753662402, 86448.56775716333, 91817.54091229769, 92830.0, 94057.58913616164, 94761.0, 11133.165012624248, 11286.548538058385, 11345.829812552984, 11880.99011584025, 11989.820152697543, 11299.943500282447, 11538.423078845855, 11966.820497692715, 12307.44616492278, 12561.560345387868, 10106.494675266355, 11499.942500287445, 11642.185047046625, 11685.532578697097, 11703.824442633537, 11299.322040677585, 11414.600488982845, 11598.594049208237, 11650.184487085822, 11785.233959792586, 11273.849102944418, 11383.54465821358, 11620.128490363088, 11723.944844963995, 12146.757064858477, 9356.625734970798, 9369.390989585656, 9589.712308630753, 9634.373765705206, 10082.798344033225, 9296.39573427725, 9795.51022448889, 9808.117269445784, 9810.362326448758, 9815.509224538602], "value": 7578.858978348575, "unit": "score"}], "name": "dromaeo_css", "value": 7353.8290387270645, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 112.0, 113.0, 113.0, 108.0, 113.0, 112.0, 114.0, 113.0, 114.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 114.0, 107.0, 165.0, 107.0, 107.0, 128.0, 106.0, 142.0, 107.0], "value": 122.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 214.0, 260.0, 185.0, 174.0, 259.0, 224.0, 184.0, 183.0, 182.0], "value": 204.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 60.0, 79.0, 77.0, 62.0, 75.0, 83.0, 78.0, 116.0, 80.0], "value": 78.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 97.0, 125.0, 99.0, 99.0, 69.0, 95.0, 71.0, 67.0, 102.0], "value": 91.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 91.0, 130.0, 87.0, 84.0, 88.0, 85.0, 87.0, 86.0], "value": 91.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 97.0, 94.0, 94.0, 93.0, 95.0, 97.0, 93.0, 93.0], "value": 94.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 85.0, 85.0, 85.0, 84.0, 83.0, 85.0, 86.0, 85.0], "value": 84.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 56.0, 56.0, 58.0, 54.0, 56.0, 56.0, 54.0, 56.0, 55.0], "value": 55.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 69.0, 70.0, 78.0, 72.0, 68.0, 68.0, 70.0, 68.0, 69.0], "value": 69.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 85.0, 84.0, 86.0, 83.0, 81.0, 84.0, 86.0, 88.0], "value": 85.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 140.0, 139.0, 143.0, 145.0, 145.0, 133.0, 140.0, 154.0, 141.0], "value": 142.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 171.0, 168.0, 173.0, 170.0, 169.0, 169.0, 170.0, 172.0, 171.0], "value": 170.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 68.0, 68.0, 68.0, 69.0, 69.0, 68.0, 68.0, 68.0], "value": 68.2, "unit": "score"}], "name": "kraken", "value": 1469.2, "alertThreshold": 2.0}]} 21:28:01 INFO - Return code: 0 21:28:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:28:01 INFO - # TBPL SUCCESS # 21:28:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:28:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:28:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:28:01 INFO - 2016-08-16 21:28:01.679 screenresolution[1658:10373] starting screenresolution argv=screenresolution get 21:28:01 INFO - 2016-08-16 21:28:01.681 screenresolution[1658:10373] Display 0: 1600x1200x32@60 21:28:01 INFO - 2016-08-16 21:28:01.687 screenresolution[1659:10376] starting screenresolution argv=screenresolution list 21:28:01 INFO - Available Modes on Display 0 21:28:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:28:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:28:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:28:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:28:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:28:01 INFO - Intel Iris: 21:28:01 INFO - Chipset Model: Intel Iris 21:28:01 INFO - Type: GPU 21:28:01 INFO - Bus: Built-In 21:28:01 INFO - VRAM (Dynamic, Max): 1536 MB 21:28:01 INFO - Vendor: Intel (0x8086) 21:28:01 INFO - Device ID: 0x0a2e 21:28:01 INFO - Revision ID: 0x0009 21:28:01 INFO - Displays: 21:28:01 INFO - Display: 21:28:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:28:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:28:01 INFO - Display Serial Number: 1600x1200 60 21:28:01 INFO - Main Display: Yes 21:28:01 INFO - Mirror: Off 21:28:01 INFO - Online: Yes 21:28:01 INFO - Rotation: Supported 21:28:01 INFO - Return code: 0 21:28:01 INFO - Running post-action listener: _resource_record_post_action 21:28:01 INFO - [mozharness: 2016-08-17 04:28:01.920293Z] Finished run-tests step (success) 21:28:01 INFO - Running post-run listener: _resource_record_post_run 21:28:01 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 32377856; Write bytes: 703840768; Read time: 316; Write time: 2140 21:28:01 INFO - TinderboxPrint: CPU usage
53.6% 21:28:01 INFO - TinderboxPrint: I/O read bytes / time
32,377,856 / 316 21:28:01 INFO - TinderboxPrint: I/O write bytes / time
703,840,768 / 2,140 21:28:01 INFO - TinderboxPrint: CPU idle
2,249.6 (46.4%) 21:28:01 INFO - TinderboxPrint: CPU system
970.4 (20.0%) 21:28:01 INFO - TinderboxPrint: CPU user
1,629.8 (33.6%) 21:28:01 INFO - TinderboxPrint: Swap in / out
433,373,184 / 0 21:28:01 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 398690816; Write bytes: 393926656; Read time: 29728; Write time: 698 21:28:01 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 30338048; Write bytes: 293898752; Read time: 293; Write time: 1400 21:28:02 INFO - Running post-run listener: _upload_blobber_files 21:28:02 INFO - Blob upload gear active. 21:28:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:28:02 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 21:28:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:28:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:28:02 INFO - (blobuploader) - INFO - Open directory for files ... 21:28:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:28:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:28:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:28:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:28:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:28:03 INFO - (blobuploader) - INFO - Done attempting. 21:28:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:28:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:28:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:28:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:28:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:28:04 INFO - (blobuploader) - INFO - Done attempting. 21:28:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:28:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:28:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:28:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:28:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:28:07 INFO - (blobuploader) - INFO - Done attempting. 21:28:07 INFO - (blobuploader) - INFO - Iteration through files over. 21:28:07 INFO - Return code: 0 21:28:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:28:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:28:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5c3f2dd2bccaf1ebc3a75683a54deaa5557e8e7ad42a196e3ed80fe9cfc27e2a8001276ac2914da073121c6f3b7b6d307475b69ccac26bff5b0d158e406e6fd0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd2a0f9378b17a208665ea8eb5440c9e286637ea5d1c217dde067cb41fcb1c44e3cff7b79c63cb7dfe0daf0b464b67592d58d294aee8320bc606646f1a75f6ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a7d8b5992df6be98147923259f7449aac315be55e0d31522eb80ac727999984306d25dffe82c96769ca9179b8d164237072179c005ec1d07ac796b15e61e21d2"} 21:28:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:28:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:28:07 INFO - Contents: 21:28:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5c3f2dd2bccaf1ebc3a75683a54deaa5557e8e7ad42a196e3ed80fe9cfc27e2a8001276ac2914da073121c6f3b7b6d307475b69ccac26bff5b0d158e406e6fd0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd2a0f9378b17a208665ea8eb5440c9e286637ea5d1c217dde067cb41fcb1c44e3cff7b79c63cb7dfe0daf0b464b67592d58d294aee8320bc606646f1a75f6ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a7d8b5992df6be98147923259f7449aac315be55e0d31522eb80ac727999984306d25dffe82c96769ca9179b8d164237072179c005ec1d07ac796b15e61e21d2"} 21:28:07 INFO - Running post-run listener: copy_logs_to_upload_dir 21:28:07 INFO - Copying logs to upload dir... 21:28:07 INFO - mkdir: /builds/slave/test/build/upload/logs 21:28:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1277.961855 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-08-16 21:28:07.601925) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-16 21:28:07.605457) ========= 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.v0eaMXJZvE/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.oL6OHIgTA7/Listeners TMPDIR=/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5c3f2dd2bccaf1ebc3a75683a54deaa5557e8e7ad42a196e3ed80fe9cfc27e2a8001276ac2914da073121c6f3b7b6d307475b69ccac26bff5b0d158e406e6fd0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd2a0f9378b17a208665ea8eb5440c9e286637ea5d1c217dde067cb41fcb1c44e3cff7b79c63cb7dfe0daf0b464b67592d58d294aee8320bc606646f1a75f6ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a7d8b5992df6be98147923259f7449aac315be55e0d31522eb80ac727999984306d25dffe82c96769ca9179b8d164237072179c005ec1d07ac796b15e61e21d2"} build_url:https://queue.taskcluster.net/v1/task/J6QO1xH7RZ2hzApZg4ETiw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011335 build_url: 'https://queue.taskcluster.net/v1/task/J6QO1xH7RZ2hzApZg4ETiw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5c3f2dd2bccaf1ebc3a75683a54deaa5557e8e7ad42a196e3ed80fe9cfc27e2a8001276ac2914da073121c6f3b7b6d307475b69ccac26bff5b0d158e406e6fd0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd2a0f9378b17a208665ea8eb5440c9e286637ea5d1c217dde067cb41fcb1c44e3cff7b79c63cb7dfe0daf0b464b67592d58d294aee8320bc606646f1a75f6ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a7d8b5992df6be98147923259f7449aac315be55e0d31522eb80ac727999984306d25dffe82c96769ca9179b8d164237072179c005ec1d07ac796b15e61e21d2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-16 21:28:07.640566) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 21:28:07.640916) ========= 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.v0eaMXJZvE/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.oL6OHIgTA7/Listeners TMPDIR=/var/folders/zy/bdsjk76j7tl5nrllnsr13pf000000w/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.005277 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 21:28:07.689209) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-16 21:28:07.689540) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-16 21:28:07.689864) ========= ========= Total master_lag: 0.19 =========